builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1475079903.32 results: success (0) buildid: 20160928063004 builduid: c23f3af6c7c240c8a853bdacfb8c43bb revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.318081) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.318632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.319016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.333648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.333992) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 09:25:04-- 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% 225M=0s 2016-09-28 09:25:04 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088299 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.436524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.436926) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017779 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:03.490220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:25:03.490942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --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=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 09:25:04,656 truncating revision to first 12 chars 2016-09-28 09:25:04,656 Setting DEBUG logging. 2016-09-28 09:25:04,656 attempt 1/10 2016-09-28 09:25:04,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc513f0359eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 09:25:05,865 unpacking tar archive at: fx-team-fc513f0359eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.535747 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 09:25:05.042262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:05.042745) ========= script_repo_revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:05.043273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:05.043596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 09:25:05.053403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-28 09:25:05.053751) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:25:06 INFO - MultiFileLogger online at 20160928 09:25:06 in /builds/slave/test 09:25:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:25:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:06 INFO - {'append_to_log': False, 09:25:06 INFO - 'base_work_dir': '/builds/slave/test', 09:25:06 INFO - 'blob_upload_branch': 'Fx-Team', 09:25:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:06 INFO - 'branch': 'Fx-Team', 09:25:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:06 INFO - 'config_files': ('talos/linux_config.py',), 09:25:06 INFO - 'default_actions': ('clobber', 09:25:06 INFO - 'read-buildbot-config', 09:25:06 INFO - 'download-and-extract', 09:25:06 INFO - 'populate-webroot', 09:25:06 INFO - 'create-virtualenv', 09:25:06 INFO - 'install', 09:25:06 INFO - 'run-tests'), 09:25:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:06 INFO - 'download_minidump_stackwalk': True, 09:25:06 INFO - 'download_symbols': 'ondemand', 09:25:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:06 INFO - 'installer_path': 'installer.exe', 09:25:06 INFO - 'log_level': 'info', 09:25:06 INFO - 'log_name': 'talos', 09:25:06 INFO - 'log_to_console': True, 09:25:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:25:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:25:06 INFO - 'opt_config_files': (), 09:25:06 INFO - 'pip_index': False, 09:25:06 INFO - 'sps_profile': False, 09:25:06 INFO - 'sps_profile_interval': 0, 09:25:06 INFO - 'suite': 'dromaeojs-e10s', 09:25:06 INFO - 'system_bits': '32', 09:25:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:06 INFO - 'title': 'talos-linux64-ix-068', 09:25:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:06 INFO - 'use_talos_json': True, 09:25:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:06 INFO - 'work_dir': 'build'} 09:25:06 INFO - [mozharness: 2016-09-28 16:25:06.317407Z] Running clobber step. 09:25:06 INFO - Running pre-action listener: _resource_record_pre_action 09:25:06 INFO - Running main action method: clobber 09:25:06 INFO - rmtree: /builds/slave/test/build 09:25:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:06 INFO - Running post-action listener: _resource_record_post_action 09:25:06 INFO - [mozharness: 2016-09-28 16:25:06.782648Z] Finished clobber step (success) 09:25:06 INFO - [mozharness: 2016-09-28 16:25:06.782750Z] Running read-buildbot-config step. 09:25:06 INFO - Running pre-action listener: _resource_record_pre_action 09:25:06 INFO - Running main action method: read_buildbot_config 09:25:06 INFO - Using buildbot properties: 09:25:06 INFO - { 09:25:06 INFO - "project": "", 09:25:06 INFO - "product": "firefox", 09:25:06 INFO - "script_repo_revision": "production", 09:25:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:25:06 INFO - "repository": "", 09:25:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:25:06 INFO - "buildid": "20160928063004", 09:25:06 INFO - "pgo_build": "True", 09:25:06 INFO - "basedir": "/builds/slave/test", 09:25:06 INFO - "buildnumber": 776, 09:25:06 INFO - "slavename": "talos-linux64-ix-068", 09:25:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:25:06 INFO - "platform": "ubuntu64_hw", 09:25:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:25:06 INFO - "branch": "fx-team", 09:25:06 INFO - "repo_path": "integration/fx-team", 09:25:06 INFO - "revision": "fc513f0359ebca43d8b791a458583aeb3bb37f42", 09:25:06 INFO - "stage_platform": "linux64-pgo", 09:25:06 INFO - "builduid": "c23f3af6c7c240c8a853bdacfb8c43bb", 09:25:06 INFO - "slavebuilddir": "test" 09:25:06 INFO - } 09:25:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:25:06 INFO - Running post-action listener: _resource_record_post_action 09:25:06 INFO - [mozharness: 2016-09-28 16:25:06.785181Z] Finished read-buildbot-config step (success) 09:25:06 INFO - [mozharness: 2016-09-28 16:25:06.785269Z] Running download-and-extract step. 09:25:06 INFO - Running pre-action listener: _resource_record_pre_action 09:25:06 INFO - Running main action method: download_and_extract 09:25:06 INFO - mkdir: /builds/slave/test/build/tests 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:06 INFO - trying https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:25:07 INFO - Downloaded 1361 bytes. 09:25:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:25:07 INFO - Using the following test package requirements: 09:25:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:25:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:25:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'jsshell-linux-x86_64.zip'], 09:25:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:25:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:25:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:25:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:25:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:25:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:25:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:25:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:25:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:07 INFO - Expected file size: 21984091 09:25:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:25:13 INFO - Expected file size: 21984091 09:25:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:25:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:25:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:25:20 INFO - Expected file size: 14414062 09:25:21 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')]} 09:25:21 INFO - trying https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:25:25 INFO - Downloaded 59760130 bytes. 09:25:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:25 INFO - mkdir: /builds/slave/test/properties 09:25:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:25:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:25:25 INFO - Contents: 09:25:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:25:26 INFO - Running post-action listener: _resource_record_post_action 09:25:26 INFO - Running post-action listener: set_extra_try_arguments 09:25:26 INFO - [mozharness: 2016-09-28 16:25:26.292206Z] Finished download-and-extract step (success) 09:25:26 INFO - [mozharness: 2016-09-28 16:25:26.292432Z] Running populate-webroot step. 09:25:26 INFO - Running pre-action listener: _resource_record_pre_action 09:25:26 INFO - Running main action method: populate_webroot 09:25:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:25:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:25:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:25:26 INFO - '--tppagecycles', 09:25:26 INFO - '7'], 09:25:26 INFO - 'tests': ['tsvgm']}}, 09:25:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:25:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:25:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:25:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:25:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:25:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['damp', 'tps']}, 09:25:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['damp', 'tps']}, 09:25:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['dromaeo_dom']}, 09:25:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:25:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['basic_compositor_video']}, 09:25:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:25:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['a11yr', 09:25:26 INFO - 'ts_paint', 09:25:26 INFO - 'tpaint', 09:25:26 INFO - 'sessionrestore', 09:25:26 INFO - 'sessionrestore_no_auto_restore', 09:25:26 INFO - 'tabpaint']}, 09:25:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tsvgx', 09:25:26 INFO - 'tsvgr_opacity', 09:25:26 INFO - 'tart', 09:25:26 INFO - 'tscrollx', 09:25:26 INFO - 'cart']}, 09:25:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:25:26 INFO - 'tsvgr_opacity', 09:25:26 INFO - 'tart', 09:25:26 INFO - 'tscrollx', 09:25:26 INFO - 'cart']}, 09:25:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s'], 09:25:26 INFO - 'tests': ['tp5o']}, 09:25:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'tests': ['tp5o']}, 09:25:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--disable-e10s', 09:25:26 INFO - '--xperf_path', 09:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:26 INFO - 'tests': ['tp5n']}, 09:25:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:25:26 INFO - 'talos_options': ['--xperf_path', 09:25:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:25:26 INFO - 'tests': ['tp5n']}}, 09:25:26 INFO - 'talos.zip': {'path': '', 09:25:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:25:26 INFO - Running post-action listener: _resource_record_post_action 09:25:26 INFO - [mozharness: 2016-09-28 16:25:26.314198Z] Finished populate-webroot step (success) 09:25:26 INFO - [mozharness: 2016-09-28 16:25:26.314287Z] Running create-virtualenv step. 09:25:26 INFO - Running pre-action listener: _resource_record_pre_action 09:25:26 INFO - Running main action method: create_virtualenv 09:25:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:25:26 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 09:25:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:25:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:25:26 INFO - Using real prefix '/usr' 09:25:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:25:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:28 INFO - Installing pip.................done. 09:25:28 INFO - Return code: 0 09:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:25:29 INFO - Reading from file tmpfile_stdout 09:25:29 INFO - Output received: 09:25:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:25:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:25:29 INFO - Using env: {'DISPLAY': ':0', 09:25:29 INFO - 'HOME': '/home/cltbld', 09:25:29 INFO - 'LANG': 'en_US.UTF-8', 09:25:29 INFO - 'LANGUAGE': 'en_US:en', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MAIL': '/var/mail/cltbld', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SHLVL': '1', 09:25:29 INFO - 'TERM': 'linux', 09:25:29 INFO - 'TMOUT': '86400', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - '_': '/tools/buildbot/bin/python'} 09:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:29 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 09:25:29 INFO - Cleaning up... 09:25:29 INFO - Return code: 0 09:25:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:25:29 INFO - Using env: {'DISPLAY': ':0', 09:25:29 INFO - 'HOME': '/home/cltbld', 09:25:29 INFO - 'LANG': 'en_US.UTF-8', 09:25:29 INFO - 'LANGUAGE': 'en_US:en', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MAIL': '/var/mail/cltbld', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SHLVL': '1', 09:25:29 INFO - 'TERM': 'linux', 09:25:29 INFO - 'TMOUT': '86400', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - '_': '/tools/buildbot/bin/python'} 09:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:29 INFO - Downloading/unpacking psutil>=3.1.1 09:25:29 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 09:25:29 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 09:25:29 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 09:25:29 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 09:25:29 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 09:25:29 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 09:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:31 INFO - Installing collected packages: psutil 09:25:31 INFO - Running setup.py install for psutil 09:25:31 INFO - building 'psutil._psutil_linux' extension 09:25:31 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 09:25:31 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 09:25:31 INFO - building 'psutil._psutil_posix' extension 09:25:31 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 09:25:31 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 09:25:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:32 INFO - Successfully installed psutil 09:25:32 INFO - Cleaning up... 09:25:32 INFO - Return code: 0 09:25:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:25:32 INFO - Using env: {'DISPLAY': ':0', 09:25:32 INFO - 'HOME': '/home/cltbld', 09:25:32 INFO - 'LANG': 'en_US.UTF-8', 09:25:32 INFO - 'LANGUAGE': 'en_US:en', 09:25:32 INFO - 'LOGNAME': 'cltbld', 09:25:32 INFO - 'MAIL': '/var/mail/cltbld', 09:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:32 INFO - 'MOZ_NO_REMOTE': '1', 09:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:32 INFO - 'NO_EM_RESTART': '1', 09:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:32 INFO - 'PWD': '/builds/slave/test', 09:25:32 INFO - 'SHELL': '/bin/bash', 09:25:32 INFO - 'SHLVL': '1', 09:25:32 INFO - 'TERM': 'linux', 09:25:32 INFO - 'TMOUT': '86400', 09:25:32 INFO - 'USER': 'cltbld', 09:25:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:32 INFO - '_': '/tools/buildbot/bin/python'} 09:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:25:34 INFO - Installing collected packages: mozsystemmonitor 09:25:34 INFO - Running setup.py install for mozsystemmonitor 09:25:34 INFO - Successfully installed mozsystemmonitor 09:25:34 INFO - Cleaning up... 09:25:34 INFO - Return code: 0 09:25:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:25:34 INFO - Using env: {'DISPLAY': ':0', 09:25:34 INFO - 'HOME': '/home/cltbld', 09:25:34 INFO - 'LANG': 'en_US.UTF-8', 09:25:34 INFO - 'LANGUAGE': 'en_US:en', 09:25:34 INFO - 'LOGNAME': 'cltbld', 09:25:34 INFO - 'MAIL': '/var/mail/cltbld', 09:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:34 INFO - 'MOZ_NO_REMOTE': '1', 09:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:34 INFO - 'NO_EM_RESTART': '1', 09:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:34 INFO - 'PWD': '/builds/slave/test', 09:25:34 INFO - 'SHELL': '/bin/bash', 09:25:34 INFO - 'SHLVL': '1', 09:25:34 INFO - 'TERM': 'linux', 09:25:34 INFO - 'TMOUT': '86400', 09:25:34 INFO - 'USER': 'cltbld', 09:25:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:34 INFO - '_': '/tools/buildbot/bin/python'} 09:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:25:36 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 09:25:36 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 09:25:36 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 09:25:36 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 09:25:36 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 09:25:36 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 09:25:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:36 INFO - warning: no files found matching '*.txt' 09:25:36 INFO - no previously-included directories found matching 'build' 09:25:36 INFO - no previously-included directories found matching 'dist' 09:25:36 INFO - no previously-included directories found matching '.git*' 09:25:36 INFO - Installing collected packages: jsonschema, functools32 09:25:36 INFO - Running setup.py install for functools32 09:25:36 INFO - warning: no files found matching '*.txt' 09:25:36 INFO - no previously-included directories found matching 'build' 09:25:36 INFO - no previously-included directories found matching 'dist' 09:25:36 INFO - no previously-included directories found matching '.git*' 09:25:36 INFO - Successfully installed jsonschema functools32 09:25:36 INFO - Cleaning up... 09:25:37 INFO - Return code: 0 09:25:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:25:37 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')]} 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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')]} 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:37 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 09:25:37 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 09:25:37 INFO - Using env: {'DISPLAY': ':0', 09:25:37 INFO - 'HOME': '/home/cltbld', 09:25:37 INFO - 'LANG': 'en_US.UTF-8', 09:25:37 INFO - 'LANGUAGE': 'en_US:en', 09:25:37 INFO - 'LOGNAME': 'cltbld', 09:25:37 INFO - 'MAIL': '/var/mail/cltbld', 09:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:37 INFO - 'MOZ_NO_REMOTE': '1', 09:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:37 INFO - 'NO_EM_RESTART': '1', 09:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:37 INFO - 'PWD': '/builds/slave/test', 09:25:37 INFO - 'SHELL': '/bin/bash', 09:25:37 INFO - 'SHLVL': '1', 09:25:37 INFO - 'TERM': 'linux', 09:25:37 INFO - 'TMOUT': '86400', 09:25:37 INFO - 'USER': 'cltbld', 09:25:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:37 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:25:37 INFO - Cleaning up... 09:25:37 INFO - Return code: 0 09:25:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25:37 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')]} 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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')]} 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:37 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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:37 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 09:25:37 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 09:25:37 INFO - Using env: {'DISPLAY': ':0', 09:25:37 INFO - 'HOME': '/home/cltbld', 09:25:37 INFO - 'LANG': 'en_US.UTF-8', 09:25:37 INFO - 'LANGUAGE': 'en_US:en', 09:25:37 INFO - 'LOGNAME': 'cltbld', 09:25:37 INFO - 'MAIL': '/var/mail/cltbld', 09:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:37 INFO - 'MOZ_NO_REMOTE': '1', 09:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:37 INFO - 'NO_EM_RESTART': '1', 09:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:37 INFO - 'PWD': '/builds/slave/test', 09:25:37 INFO - 'SHELL': '/bin/bash', 09:25:37 INFO - 'SHLVL': '1', 09:25:37 INFO - 'TERM': 'linux', 09:25:37 INFO - 'TMOUT': '86400', 09:25:37 INFO - 'USER': 'cltbld', 09:25:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:37 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:39 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 09:25:39 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 09:25:39 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 09:25:39 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 09:25:39 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 09:25:39 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 09:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:40 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 09:25:40 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 09:25:40 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 09:25:40 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 09:25:40 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 09:25:40 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 09:25:40 INFO - Downloading docopt-0.6.1.tar.gz 09:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:40 INFO - Running setup.py install for blobuploader 09:25:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:40 INFO - Running setup.py install for requests 09:25:40 INFO - Running setup.py install for docopt 09:25:40 INFO - Successfully installed blobuploader requests docopt 09:25:40 INFO - Cleaning up... 09:25:40 INFO - Return code: 0 09:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:40 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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:40 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 09:25:40 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 09:25:40 INFO - Using env: {'DISPLAY': ':0', 09:25:40 INFO - 'HOME': '/home/cltbld', 09:25:40 INFO - 'LANG': 'en_US.UTF-8', 09:25:40 INFO - 'LANGUAGE': 'en_US:en', 09:25:40 INFO - 'LOGNAME': 'cltbld', 09:25:40 INFO - 'MAIL': '/var/mail/cltbld', 09:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:40 INFO - 'MOZ_NO_REMOTE': '1', 09:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:40 INFO - 'NO_EM_RESTART': '1', 09:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:40 INFO - 'PWD': '/builds/slave/test', 09:25:40 INFO - 'SHELL': '/bin/bash', 09:25:40 INFO - 'SHLVL': '1', 09:25:40 INFO - 'TERM': 'linux', 09:25:40 INFO - 'TMOUT': '86400', 09:25:40 INFO - 'USER': 'cltbld', 09:25:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:40 INFO - '_': '/tools/buildbot/bin/python'} 09:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:41 INFO - Running setup.py (path:/tmp/pip-OHxeGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:41 INFO - Running setup.py (path:/tmp/pip-BoT0oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:41 INFO - Running setup.py (path:/tmp/pip-iqOedO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:41 INFO - Running setup.py (path:/tmp/pip-DrLqVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:41 INFO - Running setup.py (path:/tmp/pip-H8hyPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:41 INFO - Running setup.py (path:/tmp/pip-je4QBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:41 INFO - Running setup.py (path:/tmp/pip-27CICD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:41 INFO - Running setup.py (path:/tmp/pip-BBDC6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:41 INFO - Running setup.py (path:/tmp/pip-FHOH97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:41 INFO - Running setup.py (path:/tmp/pip-Sw9zn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:41 INFO - Running setup.py (path:/tmp/pip-NYPos1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:41 INFO - Running setup.py (path:/tmp/pip-dAJ0EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:42 INFO - Running setup.py (path:/tmp/pip-dVLZVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:42 INFO - Running setup.py (path:/tmp/pip-ISIcZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:42 INFO - Running setup.py (path:/tmp/pip-QayXNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:42 INFO - Running setup.py (path:/tmp/pip-JkgQup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:42 INFO - Running setup.py (path:/tmp/pip-iduNDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:42 INFO - Running setup.py install for manifestparser 09:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozcrash 09:25:42 INFO - Running setup.py install for mozdebug 09:25:42 INFO - Running setup.py install for mozdevice 09:25:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:42 INFO - Running setup.py install for mozfile 09:25:42 INFO - Running setup.py install for mozhttpd 09:25:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozinfo 09:25:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozInstall 09:25:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozleak 09:25:43 INFO - Running setup.py install for mozlog 09:25:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for moznetwork 09:25:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozprocess 09:25:43 INFO - Running setup.py install for mozprofile 09:25:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozrunner 09:25:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:43 INFO - Running setup.py install for mozscreenshot 09:25:43 INFO - Running setup.py install for moztest 09:25:44 INFO - Running setup.py install for mozversion 09:25:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:44 INFO - Cleaning up... 09:25:44 INFO - Return code: 0 09:25:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:44 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')]} 09:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:44 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')]} 09:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:44 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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:44 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 09:25:44 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 09:25:44 INFO - Using env: {'DISPLAY': ':0', 09:25:44 INFO - 'HOME': '/home/cltbld', 09:25:44 INFO - 'LANG': 'en_US.UTF-8', 09:25:44 INFO - 'LANGUAGE': 'en_US:en', 09:25:44 INFO - 'LOGNAME': 'cltbld', 09:25:44 INFO - 'MAIL': '/var/mail/cltbld', 09:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:44 INFO - 'MOZ_NO_REMOTE': '1', 09:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:44 INFO - 'NO_EM_RESTART': '1', 09:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:44 INFO - 'PWD': '/builds/slave/test', 09:25:44 INFO - 'SHELL': '/bin/bash', 09:25:44 INFO - 'SHLVL': '1', 09:25:44 INFO - 'TERM': 'linux', 09:25:44 INFO - 'TMOUT': '86400', 09:25:44 INFO - 'USER': 'cltbld', 09:25:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:44 INFO - '_': '/tools/buildbot/bin/python'} 09:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:44 INFO - Running setup.py (path:/tmp/pip-8wGxUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:44 INFO - Running setup.py (path:/tmp/pip-3I0nSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:44 INFO - Running setup.py (path:/tmp/pip-vVDwuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:44 INFO - Running setup.py (path:/tmp/pip-DvaUvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:44 INFO - Running setup.py (path:/tmp/pip-4GTWAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:44 INFO - Running setup.py (path:/tmp/pip-wDXR2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:44 INFO - Running setup.py (path:/tmp/pip-VigbnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:44 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)) 09:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:44 INFO - Running setup.py (path:/tmp/pip-cVt8q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:45 INFO - Running setup.py (path:/tmp/pip-5MmfT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:45 INFO - Running setup.py (path:/tmp/pip-OLgOuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:45 INFO - Running setup.py (path:/tmp/pip-e2X01p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:45 INFO - Running setup.py (path:/tmp/pip-oBL5Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:45 INFO - Running setup.py (path:/tmp/pip-GnF5MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:45 INFO - Running setup.py (path:/tmp/pip-KNpSgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:45 INFO - Running setup.py (path:/tmp/pip-HEi0no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:45 INFO - Running setup.py (path:/tmp/pip-yv_AHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:45 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)) 09:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:45 INFO - Running setup.py (path:/tmp/pip-mJwExH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 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)) 09:25:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:45 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 09:25:47 INFO - Downloading blessings-1.6.tar.gz 09:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:47 INFO - Installing collected packages: blessings 09:25:47 INFO - Running setup.py install for blessings 09:25:47 INFO - Successfully installed blessings 09:25:47 INFO - Cleaning up... 09:25:47 INFO - Return code: 0 09:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:48 INFO - Reading from file tmpfile_stdout 09:25:48 INFO - Current package versions: 09:25:48 INFO - argparse == 1.2.1 09:25:48 INFO - blessings == 1.6 09:25:48 INFO - blobuploader == 1.2.4 09:25:48 INFO - docopt == 0.6.1 09:25:48 INFO - functools32 == 3.2.3-2 09:25:48 INFO - jsonschema == 2.5.1 09:25:48 INFO - manifestparser == 1.1 09:25:48 INFO - mozInstall == 1.12 09:25:48 INFO - mozcrash == 0.17 09:25:48 INFO - mozdebug == 0.1 09:25:48 INFO - mozdevice == 0.48 09:25:48 INFO - mozfile == 1.2 09:25:48 INFO - mozhttpd == 0.7 09:25:48 INFO - mozinfo == 0.9 09:25:48 INFO - mozleak == 0.1 09:25:48 INFO - mozlog == 3.4 09:25:48 INFO - moznetwork == 0.27 09:25:48 INFO - mozprocess == 0.23 09:25:48 INFO - mozprofile == 0.28 09:25:48 INFO - mozrunner == 6.12 09:25:48 INFO - mozscreenshot == 0.1 09:25:48 INFO - mozsystemmonitor == 0.3 09:25:48 INFO - moztest == 0.7 09:25:48 INFO - mozversion == 1.4 09:25:48 INFO - psutil == 3.1.1 09:25:48 INFO - requests == 1.2.3 09:25:48 INFO - wsgiref == 0.1.2 09:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:48 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 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:48 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 09:25:48 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 09:25:48 INFO - Using env: {'DISPLAY': ':0', 09:25:48 INFO - 'HOME': '/home/cltbld', 09:25:48 INFO - 'LANG': 'en_US.UTF-8', 09:25:48 INFO - 'LANGUAGE': 'en_US:en', 09:25:48 INFO - 'LOGNAME': 'cltbld', 09:25:48 INFO - 'MAIL': '/var/mail/cltbld', 09:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:48 INFO - 'MOZ_NO_REMOTE': '1', 09:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:48 INFO - 'NO_EM_RESTART': '1', 09:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:48 INFO - 'PWD': '/builds/slave/test', 09:25:48 INFO - 'SHELL': '/bin/bash', 09:25:48 INFO - 'SHLVL': '1', 09:25:48 INFO - 'TERM': 'linux', 09:25:48 INFO - 'TMOUT': '86400', 09:25:48 INFO - 'USER': 'cltbld', 09:25:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:48 INFO - '_': '/tools/buildbot/bin/python'} 09:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 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)) 09:25:48 INFO - Cleaning up... 09:25:48 INFO - Return code: 0 09:25:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b28950f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', '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 09:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:25:48 INFO - Using env: {'DISPLAY': ':0', 09:25:48 INFO - 'HOME': '/home/cltbld', 09:25:48 INFO - 'LANG': 'en_US.UTF-8', 09:25:48 INFO - 'LANGUAGE': 'en_US:en', 09:25:48 INFO - 'LOGNAME': 'cltbld', 09:25:48 INFO - 'MAIL': '/var/mail/cltbld', 09:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:48 INFO - 'MOZ_NO_REMOTE': '1', 09:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:48 INFO - 'NO_EM_RESTART': '1', 09:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:48 INFO - 'PWD': '/builds/slave/test', 09:25:48 INFO - 'SHELL': '/bin/bash', 09:25:48 INFO - 'SHLVL': '1', 09:25:48 INFO - 'TERM': 'linux', 09:25:48 INFO - 'TMOUT': '86400', 09:25:48 INFO - 'USER': 'cltbld', 09:25:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:48 INFO - '_': '/tools/buildbot/bin/python'} 09:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:48 INFO - Cleaning up... 09:25:48 INFO - Return code: 0 09:25:48 INFO - Running post-action listener: _resource_record_post_action 09:25:48 INFO - Running post-action listener: _start_resource_monitoring 09:25:48 INFO - Starting resource monitoring. 09:25:48 INFO - [mozharness: 2016-09-28 16:25:48.486907Z] Finished create-virtualenv step (success) 09:25:48 INFO - [mozharness: 2016-09-28 16:25:48.487502Z] Running install step. 09:25:48 INFO - Running pre-action listener: _resource_record_pre_action 09:25:48 INFO - Running main action method: install 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:48 INFO - Reading from file tmpfile_stdout 09:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:48 INFO - Reading from file tmpfile_stdout 09:25:48 INFO - Output received: 09:25:48 INFO - Usage: mozinstall [options] installer 09:25:48 INFO - Options: 09:25:48 INFO - -h, --help show this help message and exit 09:25:48 INFO - -d DEST, --destination=DEST 09:25:48 INFO - Directory to install application into. [default: 09:25:48 INFO - "/builds/slave/test"] 09:25:48 INFO - --app=APP Application being installed. [default: firefox] 09:25:48 INFO - mkdir: /builds/slave/test/build/application 09:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:26:05 INFO - Reading from file tmpfile_stdout 09:26:05 INFO - Output received: 09:26:05 INFO - /builds/slave/test/build/application/firefox/firefox 09:26:05 INFO - Running post-action listener: _resource_record_post_action 09:26:05 INFO - [mozharness: 2016-09-28 16:26:05.821913Z] Finished install step (success) 09:26:05 INFO - [mozharness: 2016-09-28 16:26:05.822161Z] Running run-tests step. 09:26:05 INFO - Running pre-action listener: _resource_record_pre_action 09:26:05 INFO - Running main action method: run_tests 09:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:26:05 INFO - Python 2.7.3 09:26:05 INFO - Return code: 0 09:26:05 INFO - grabbing minidump binary from tooltool 09:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:05 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 0x12b4930>, '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 0x12b5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b5cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:26:05 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 09:26:05 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 09:26:05 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 09:26:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:26:05 INFO - Return code: 0 09:26:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:26:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:26:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 09:26:05 INFO - Using env: {'DISPLAY': ':0', 09:26:05 INFO - 'HOME': '/home/cltbld', 09:26:05 INFO - 'LANG': 'en_US.UTF-8', 09:26:05 INFO - 'LANGUAGE': 'en_US:en', 09:26:05 INFO - 'LOGNAME': 'cltbld', 09:26:05 INFO - 'MAIL': '/var/mail/cltbld', 09:26:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:26:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:05 INFO - 'MOZ_NO_REMOTE': '1', 09:26:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:26:05 INFO - 'NO_EM_RESTART': '1', 09:26:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:05 INFO - 'PWD': '/builds/slave/test', 09:26:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:26:05 INFO - 'SHELL': '/bin/bash', 09:26:05 INFO - 'SHLVL': '1', 09:26:05 INFO - 'TERM': 'linux', 09:26:05 INFO - 'TMOUT': '86400', 09:26:05 INFO - 'USER': 'cltbld', 09:26:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747', 09:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:05 INFO - '_': '/tools/buildbot/bin/python'} 09:26:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 09:26:06 INFO - mozversion application_buildid: 20160928063004 09:26:06 INFO - mozversion application_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 09:26:06 INFO - mozversion application_display_name: Nightly 09:26:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:26:06 INFO - mozversion application_name: Firefox 09:26:06 INFO - mozversion application_remotingname: firefox 09:26:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:26:06 INFO - mozversion application_vendor: Mozilla 09:26:06 INFO - mozversion application_version: 52.0a1 09:26:06 INFO - mozversion platform_buildid: 20160928063004 09:26:06 INFO - mozversion platform_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 09:26:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:26:06 INFO - mozversion platform_version: 52.0a1 09:26:06 INFO - using testdate: 1475079966 09:26:06 INFO - actual date: 1475079966 09:26:06 INFO - starting webserver on 'localhost:52913' 09:26:06 INFO - SUITE-START | Running 2 tests 09:26:06 INFO - TEST-START | dromaeo_css 09:26:06 INFO - operating with platform_type : linux_ 09:26:06 INFO - Initialising browser for dromaeo_css test... 09:26:06 INFO - TEST-INFO | started process 5529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQngWYG/profile http://localhost:52913/getInfo.html) 09:26:11 INFO - PROCESS | 5529 | __metrics Screen width/height:1600/1200 09:26:11 INFO - PROCESS | 5529 | colorDepth:24 09:26:11 INFO - PROCESS | 5529 | Browser inner width/height: 1024/697 09:26:11 INFO - PROCESS | 5529 | __metrics 09:26:11 ERROR - PROCESS | 5529 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:26:12 INFO - TEST-INFO | 5529: exit 0 09:26:12 INFO - Browser initialized. 09:26:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:26:12 INFO - TEST-INFO | started process 5649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQngWYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:24 INFO - PROCESS | 5649 | RSS: Main: 185286656 09:26:24 INFO - PROCESS | 5649 | 09:27:14 INFO - PROCESS | 5649 | 1475080034256 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] 09:29:24 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52913/tests/dromaeo/cssquery-ext.html) 09:29:25 INFO - PROCESS | 5649 | RSS: Main: 197623808 09:29:25 INFO - PROCESS | 5649 | 09:32:28 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-ext.html (next: http://localhost:52913/tests/dromaeo/cssquery-jquery.html) 09:32:28 INFO - PROCESS | 5649 | RSS: Main: 196890624 09:32:28 INFO - PROCESS | 5649 | 09:35:30 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52913/tests/dromaeo/cssquery-mootools.html) 09:35:31 INFO - PROCESS | 5649 | RSS: Main: 199294976 09:35:31 INFO - PROCESS | 5649 | 09:38:33 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52913/tests/dromaeo/cssquery-prototype.html) 09:38:33 INFO - PROCESS | 5649 | RSS: Main: 195186688 09:38:33 INFO - PROCESS | 5649 | 09:41:36 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52913/tests/dromaeo/cssquery-yui.html) 09:41:36 INFO - PROCESS | 5649 | RSS: Main: 199278592 09:41:36 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | Cycle 1(1): loaded http://localhost:52913/tests/dromaeo/cssquery-yui.html (next: http://localhost:52913/tests/dromaeo/cssquery-dojo.html) 09:44:39 INFO - PROCESS | 5649 | RSS: Main: 199499776 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | __start_tp_report 09:44:39 INFO - PROCESS | 5649 | _x_x_mozilla_page_load 09:44:39 INFO - PROCESS | 5649 | _x_x_mozilla_page_load_details 09:44:39 INFO - PROCESS | 5649 | |i|pagename|runs| 09:44:39 INFO - PROCESS | 5649 | |0;dojo.html;3060.3267281198137;3065.4941934580797;3070.8464576771157;3098.4732595458763;3108.8756449741995;5336.546393556552;5387.272718183049;5415.160650099236;5457.617966742329;5509.669419834812;5376.381716102649;5400.189971504276;5418.187271909215;5447.291852059237;5489.258950041753;4897.828575999841;4988.351514303135;5012;5028.446870844223;5050.949490505084;5041.8235361762345;5074.517920797518;5103.183490641498;5135.845924622248;5141.30592370029;4851.830185943475;4883.12103821312;4934.284528743348;4952.603791696655;5002.7743202915335;4985.202367621163;4987.077390682735;5034.949650503485;5076.466970968069;5088;4948.307236986825;4979.153543897546;4983.227599722049;5005.449400565934;5075.390953085654;5294.973525132388;5328.733563321818;5452.454754524555;5462.344518657746;5470.9452905470835;5756.942430575725;5759.078547432433;5768.278965129359;5772.134179873053;5792.739326730307;5778.3643799182055;5782.56630752691;5860.912086318709;5862.355140934494;5869.060950247983;5385.030694475032;5434.266374039494;5458.727063646802;5460.808871689472;5460.890782184334;5879.059350503899;5917.378675239038;5925.4370834770625;5934.43622855828;6011.27864656244;5660.575456840671;5708.885822283614;5710.486056254957;5712.371639119693;5712.714364281853;5598;5775.27809023872;5788.160716696139;5793.710314484259;5847.38602446737;5833.154192642043;5840.1531777892815;5846.386129456431;5888.352281249059;5896.587238893322;5851.38560451155;5862.794802181988;5867.618604790675;5867.911981320283;5868.031774757117;4343.2182207203;4389.517153113155;4401.471823381215;4479.328100784908;4492.932606010912;3939.5666476687543;3971.602839716063;3989.501312335958;4001.7598944063448;4024.014116541466;5472.288602481652;5525.944740552543;5536.335639723259;5541.141123125922;5571.554275657938;5609;5655.830325090172;5827.388124246978;5831.3877042910735;5839.649621022752;5575.0522411190195;5624.0439125348785;5636.520895723827;5653.208550802891;5706.743196556165;5066.341375621146;5095.159298715745;5100.770465329069;5101.005303965765;5147.1507201312115;5780.190773291826;6082.615514776056;6146.477549408351;6150.50795936324;6152.538559608047;5667;5673.730607366154;5724.799632013026;5735.569832262514;5743.655380677173;5916.970415147896;5927.881442371215;5932.762689492372;5941.673207973603;5958.553108516792;5498.065328894178;5616.887662246814;5710.628809127394;5784.392638772868;5797.594168408171;5787.074068149076;5824.417558244311;5828.59199856006;5839.124131380327;5908.734106965283;5714.114312281603;5724.713764311851;5726.026575482261;5729.4843464088435;5735.168400581809;5525.336959564878;5572.665640061609;5702.201691763239;5716.342620598684;5750.769969201185;5676.659400435987;5685.914711279417;5688.004599195042;5767.250257466502;5776.913346299725;5702.486776190163;5715.485606295453;5721.5136713379825;5722.4277572242445;5734.569907256889;5408.8377348679605;5451.700156491431;5612.045952188219;5623.606347555632;5635.6618602883955 09:44:39 INFO - PROCESS | 5649 | |1;ext.html;569.9715014249288;575.3987083497744;586.8503531599441;588.4674369695427;599.6581948289476;42058.15883682325;44336.556634433684;44371.55628443719;47146;47194;44209.778951105196;44403.77798111013;44761.55238447615;45035.549644503546;45154;8822.294216462684;8906.86639700405;8955.596998135066;8976.8653470198;9009.819803603925;8822.161894620001;8832.602532886003;8844.73465796024;8853.690120845771;8879.600417981173;8838.204561589455;8867.24628406583;8899.510526921016;8917;8941.374103812735;8776.956115219415;8780.385373023892;8831.69089081879;8846.734597962039;8858.247049000842;8801.383903126783;8898.288136949028;8901.688440904538;8904.198622123975;8909.242714369286;41764.79117604423;41782.58217417818;41800.37299440511;41884.79057604723;42278.15443691109;3338.5159151923076;3345.414552453311;3353.96646033539;3632.909177270563;3773.64150405711;31453.37093258145;31460.685393146003;31573.684263157535;32948.50577241343;33296.3340733184;4217.8312867485265;4246.745195288293;4268.622498349988;4290.935635965432;4338.501072376685;335406;337283.313583433;339656;339719;340305;55519;56048.719756400955;56055;56073.71963140158;56098.1585276213;35496.46755298621;36134.638653613125;59340.70329648324;59394.40605593889;59602.70198648979;13072.973689078208;13299.46802127904;13327.067105302536;13382.866171338357;13470.191788492722;10584.417857017785;10636.627718029831;10657.893421065844;10664.840027399596;10699.411532365639;18368.448946531626;18756.249750009847;18813;18825.717614235797;18890;6920.342567456084;7061.576305421691;7130.180029296594;7155.713771449084;7436.702531898772;921.9032001639865;966.8673497866861;1081.7728277061747;1136.86926003509;1142.1269118645428;32216;32532.674673252965;32665.83667081697;32707.836460817543;32904.67095329016;1013.9239557033252;1016.9644062457778;1032.7521394865178;1073.5061871539178;1113.1484414422973;16020.359185632677;16802.747958780383;16834.494965151065;16869.83130168707;16936.40722574704;598748;599330;601027;610521;611501;56164;56575.43424565784;56625;56713.06017157518;56958.14562781562;1257.3713143428286;1301.5184381778613;1303.5633062923837;1309.5023890921389;1326.3699742622177;29424;30378.54432183563;30423;31170.68829311678;31516.212094697818;49743.25385119298;49926.25110623271;49955.75022124866;49975;50080;441619;446416;447383;447731;449328;27562;27868.860655696593;28121.578176326962;28169.43661126807;28269;46255;46935.765321173174;47060.52939470561;47061.76469117632;48013.75993120012;39625.603743962194;40082.59917400789;40505.43350988314;40969.38545921754;41493.58506415018;39299.410508842964;40527;40595.188096238504;41452.79273603613;41878.58121418747;39552;40323.3951490722;40348.79825600853;41051.1789764209;41061.48323684333;32983.67016329902;36043.63956360508;36528.63471365252;36581.08547286339;36794.63205367912;27436.58845117285;27767.444651107267;27950.58074128849;28167;28237.57643635306 09:44:39 INFO - PROCESS | 5649 | |2;jquery.html;399.9520057593089;400.3014739279956;405.6065616352137;408.3935355996345;419.73346924702804;17965.820341796578;18592.34926777563;18832.246710131614;19381.32165374214;19385.12766925488;18319.816801831978;18418.907905460455;18497.537561560966;18551.721724174113;18650.813491865076;5649.519790817785;5670.68811215382;5807.883842323151;5823.854403639922;5899.852503687421;5735.655860648374;5763.279590051244;5780.335261444925;5790.826275211751;5809.215755872967;5602.1036634138545;5763.39484354143;5765.308163020443;5777.653340799545;5787.565932555054;5725.685087320196;5753.079507278836;5780.624259423124;5802.100674395476;5808.970955145219;5046.142155833517;5089.872753181163;5191.610629202787;5194.68831870089;5199.194124910645;21884.45288867775;21966.121355145777;22009.33971980843;22052;22146.667799983014;2304.182015384531;2385.880705964712;2422.219668543619;2575.420530380668;2849.0313293480317;13751.793723094162;14155.575332740034;14164.716705665933;14361.784573231409;14470.131792092508;1839.9774211597303;1904.3810761502566;1936.3295136337501;1941.631090092878;1974.8123928226796;80115.19596814142;81464.59267703682;81497.18502815014;83178;83810.58094709548;9843.507824608741;10177.491125443697;10411;10450.634227801991;11277.913585986618;14692;14736;14776.408943642135;14793.11241325524;14801.777973330409;6838.623875686885;7117.92882071183;7229.783106506813;7334.156571994289;7398.149212840484;6252.624842509373;6320.399562041599;6446.645434501147;6594.901076483857;6774.390304872585;6260.342664020212;6454.059610481049;6481.254655714653;6494.1232933553365;6605.504587155887;1904.7619047619048;1944.397236856579;1973.6644770389069;1980.069367397321;1981.6928376101728;849.5582297205418;947.3747326764302;961.6778379243032;1067.0503252105632;1072.453048945028;17398.65202695939;18475.538111547317;19161.32935347256;19345.226190952206;19448;961.7595601099725;967.1730670276953;976.0483528559597;1026.14829691356;1043.0768769638773;10160.4919754012;10801.594067847116;10936.289141205796;10938.179636527293;11037.779244415067;448828;449947;460893;465036;465638;79697.60151199206;80384.59807700924;80476.1714297144;81763;83019.5849020751;1016.2479764974014;1033.2818691009677;1039.2361614213546;1047.1884289675563;1049.1763965287366;16375;16516.256768445208;16708.331666733193;17003.06483143439;17297.394591189248;38258.61741382551;38335.42496862494;39175.80412097921;39309.80345098256;39492.40761388639;51321;51970.48029519656;52533.212001820764;52617.47382526126;53713.46286537085;7869.331106855752;7893.486923349964;8016.318612917734;8208.58957052133;8739.300855931637;12608.49566017349;12768.233905965672;12913.612591622266;13221.801672975105;13272.203667779964;10868.402237876993;10909;10974.506147223554;10985.725356865823;11519.88480115188;11177.046494435337;11242.156838237;11254.043406310555;11585.304881707125;11629.59296424621;11171.218014739216;11181.552737890393;11296;11362.14783891228;11677.240979336317;7589.696412143452;8185.263326300424;8386.538740369338;8578.099299573705;8584.699535516227;10292.794144117226;10406.843897341394;10483.842742359024;10535.262531623019;10987.505562249878 09:44:39 INFO - PROCESS | 5649 | |3;mootools.html;1435.2751860310539;1480.9703805923882;1630.494546690526;1777.8222177782216;1800.522861441718;7636;7827.882581761278;8644.39489235753;9390.718278451648;9393.483358415293;8721.127887211276;8933.731988040368;8937.195652391283;9177.403468774542;9196.632134714604;2347.6595893595418;2380.071772008918;2409.795167410772;2415.625578035407;2418.613021916494;2323.3030090972725;2364.775346342095;2369.857808531485;2371.893264803088;2423.115562819567;2331.0326214620914;2342.824288178385;2363.444590521226;2408.0608562660577;2408.084927727461;2282.9657555136687;2307.215546714117;2313.398516385735;2320.9419764505938;2350.717913850332;2275.601769690314;2282.4864405508793;2284.725832900046;2289.645105008726;2291.598970180212;9210.585523651453;9351.579178936965;9353.11145441182;9384.343095983284;9399.71800845969;5286.867828304285;5330.973345133289;5360.731963401853;5468.125099983983;5483.396826349099;3356.2951780126205;3509.5437593112733;3545.5213546171194;3572.732045096602;3588.2464682416726;1047.8271085270922;1079.1474734959372;1079.578964203961;1091.4488183467377;1107.501624269074;12531.561395351118;12771.552995645108;12779;12856.228626282453;12878.87121128786;4790.137775200427;4796.25658023007;4807.591354734886;4838.975805121022;4936.111499929975;10738.355698658106;10764.56941722338;10806.35161890289;10848.457577121113;10852.837207441895;5157.819476318386;5243.764030618631;5267.868303292448;5284.5772338212855;5287.68273903567;4122.855700050483;4247.405363249148;4785.952140478551;4824.445188803263;4912.091263116335;3853.537575490959;3936.6653834423823;4047.757134571876;4055.5538890721996;4205.600467955539;1292.7156025674337;1300.681333073403;1306.8366454193226;1322.08115359824;1324.0069947539346;811.6185392865344;869.8782170496136;904.8733177355175;931.669257413622;932.3195812040384;6163.291221509494;6165.136880836686;6195.4424101831055;6317.842053948688;6408.455281301049;458.7843713454671;467.264059106908;467.9508651591602;471.82542459290283;920.7744102694883;3976.1451287973223;4136.565660605654;4176.749395036247;4180.059486615487;4328.285832837547;11171;11382.373969431761;11487.483063262172;11490.712732181762;11492.080633549296;11053;11275.154363422776;11327.943360283145;11347.262427942158;11424.771504569862;8228.711995080263;8444.61999210037;8510.617022234015;8515.191056849713;8556.443831150955;5806.564507662027;5825.300963884361;5826.533877289722;5858.912116318344;6017.939820601913;10413.219008574235;10501.527431265458;10514.78970420572;10654;10703.411312377893;10038.548265327932;10429.12275790365;10572.202725536523;10573.312734672221;10707.089897358812;7672.961635191788;7717;7862.253085956825;8426.41015128935;8660.09069047741;7966.203379662219;8380.24577788002;8382.874256886274;8392.16078392156;8399.076101628938;7533.3973282138395;7800.921990780246;7855.293023627901;7925.326347260548;8069.031716194094;7654.425918056057;7711.38308935295;7717.1896950819355;7837.333826624801;7940.960295198487;7285.453590980804;7445.627718614156;7449.813754656177;7457.627118643937;7466.290702383265;5191.662541934762;5200.947990520046;5310.7875684973715;5311.654742441729;5528.695921724344;5253.842384728464;5287.206918962186;5394.271773310553;5414.10667239901;5511.448855114457 09:44:39 INFO - PROCESS | 5649 | |4;prototype.html;324.70938510033534;331.63685764088314;333.7046713658412;338.8847791750805;344.5864962045546;5351.892962140755;5499.890002199963;5545.77816887324;5600.439956004403;5650.604457687963;5268.578513718903;5378.811741589046;5398.569379114538;5408.215808707735;5433.266509021281;4273.230818452677;4291.527931927485;4329.458817647794;4336.65306775458;4345.521992580813;4277.679174061942;4312.504062032859;4364.934525982113;4368.956310436903;4369.715968462056;4287.8070486828165;4290.420793192926;4290.4851417829905;4297.419848320484;4304.504981927087;4271.316589345721;4299.140171965604;4315.870523884289;4321.157374311994;4336.460556502428;3777.697784177259;3838.865639702597;3867.588330259463;3879.301725689375;3886.863959761423;5265.947340526584;5276.498732620395;5341.545968592674;5344.6793192408195;5377.4084850666395;4954.777035033432;4957.7769000395065;4978.6514943953935;4986.700797952134;5007.624428167902;5595.048841696881;5780.745509251396;5788.82633520995;5794.5074668653215;5819.621724587888;4160.5007399112;4163.208990291835;4165.312723400635;4165.479315085614;4176.14389050247;5936.614120082224;5950.97024514879;6046.486048685911;6050.334463209044;6061.454469097803;4123.134141830189;4319.222539942778;4319.222539942841;4346.434963454731;4347.956520434818;4306.1172459645695;4353.717008394444;4377.102693947733;4379.642310883636;4405.889852753643;4978.054169707744;4981.252812078217;4988.301637770715;4994.275830004702;4995.275685025724;5625.606207565431;5816;5840.984860223216;5853.590248682552;5853.678047707332;1487.2043456750587;1511.3274592806315;1511.8866085043667;1514.5759187427318;1517.339957118657;928.6656803550717;955.8996305387973;976.682578162086;978.2614126334714;985.1773768903046;4915.648196745852;4918.827841025547;4928.753562321941;4932.482089380564;4974.751262436864;5172.250023746611;5234.685918844882;5237.029786043837;5240.292560504359;5280.419153893069;4624.468186158568;4884.511548845087;4919.434265059564;4937.235148316954;4975.900481990412;2741.849198294113;2752.605233446914;2755.531559634827;2760.3651160233258;2761.351082495612;5349.683196418246;5357.491038351351;5393.83818485446;5412.995787337986;5448.528897197734;5366.195070739421;5369.624126311199;5754.625949313281;6145.877082458326;6183.288921774054;6119.694015299217;6165.260168779685;6182.350853160354;6223.96888015557;6237.189165408558;5956.940430595639;5981.880362392815;6066.514678825772;6105.13058862334;6111.541634377529;5897.882042359214;5913.728548362123;5925.585209035498;5932.644041357532;6009.489193418608;6251.624902505864;6303.36966303366;6332.2454732191645;6340.365963403623;6341;4151.937720934128;4281.871543853689;4289.469213164248;4294.634956028773;4303.160883627663;5989.610675306091;6042.401767240129;6054.394560544087;6055.122007308827;6074.726637301421;5641;5924.289085309791;5927;5932.228810254639;5953.077273022688;5802.448767367094;5821.854453638693;5832.795852145155;5845.912311315419;5848.2689663792025;5797.130430435468;5819.883602328015;5836.766529338949;5847.152162936265;5847.298324201123;5777.50891174238;5847.80120075375;5860.677662728591;5872.500837428866;5903.645781253139;5706.743196556082;5751.252337196138;5752.942470575241;5754.913676294943;5786.479216870502 09:44:39 INFO - PROCESS | 5649 | |5;yui.html;683.2074793239843;752.2740555364076;785.579714852554;794.3864685185738;812.8902598149256;13484.460621575137;13824.926261060833;15669.608259793511;15732.60668483287;16111.274992625331;14509.637259068502;14781.704365912703;14784.112953222813;14828.332725027372;14841.703165936702;786.8072322281049;806.4838503357827;809.1221025187679;809.2352726673296;809.4455298120777;784.7606480023591;802.1096582793095;804.4770898915693;812.3663542436909;814.5153633588005;834.586879494651;843.4053991935671;847.5084451018395;848.4909054567241;850.0394554153797;836.8117173635944;837.1586555511702;839.4207996482438;840.6469282901196;843.6288033265405;621.3258614403378;621.9751209951596;622.9314775374705;623.5198896849446;624.3132554190399;14277.928610356881;14291.642708932255;14351.78472322916;14357.78463323051;14367.209803460806;13507.594772156852;13636.659083522893;14108.929455352658;14194.574162775134;14267.215303158322;11854.585089521825;11924.940375298069;12009.639710808602;12050.819237711441;12079.214851034743;3716.7955762433057;3728.254349130185;3729.981350093259;3746.1758413149337;3915.7846318452475;83044.58477707572;84108;85397.57301213517;85835.57082214548;86095;10465.529051192714;10844;10990.670279891616;11089.168312376443;11255.212135150625;20202.797972020093;20235.797642023685;20358;20365.592688146153;20515.897420512803;7633.274838890296;7966.561839098789;8065.717699880476;8077.959610202029;8146.959265203636;4525.909481810345;4652.860414187579;4711.269753188261;4814.903701926012;4819.542143496362;3310.6027276726463;3430.125318043883;3450.6721861423125;3457.913552161216;3461;606.369375849112;630.076937286877;631.3434028610194;647.7862305439194;650.1320736816309;512.0484910911495;599.9670018149044;660.6069388713707;675.1391975231619;684.5752611738867;9192.58633361487;9700.175485083846;9740.610375584898;9825;9881.901180988241;559.1249694228519;658.8188248231775;671.7078071039114;673.4275865514273;678.1827897383641;4224.429701990192;4619.745913974763;4662.7668616569035;4680.438347398334;4722.291656251589;77554;78148;92882;96804.51597741967;112208;100966.4951675237;101048;101481.8518148194;102785.48607257065;105343;25267.62098568523;25584.36039099;79204.62386128426;87472.5626371864;88019.55990220008;9196.35625506208;9834.950825245827;9853;9950.601975921172;9984.950075249577;49230.50769492259;49325.50674493209;49920.50079499158;51055.234171486714;51312.74343628258;67998.3200167992;68283.65858170677;72329.63835180791;76225;77267;12095.637130886087;12286.692832679255;12293.385330733248;12854.742905142031;13060.738785224052;14908.925455372653;14918.925405372904;15016.399344026117;15049.774253386428;15252.466163684217;13074.215547067206;14247.287635618384;14498.927505362406;14529.927350363181;14952.925235373754;12886.355682216039;13290.335483225994;13356.666083347995;13380.866191338351;13437.596872093853;11348.489317980875;13328.40022198984;13437.731245375233;14000.299985000505;14271.072380295247;10840.241183117107;11502.424878756196;11547.538098476303;11702;11767.176297659424;10908.945455272673;11917.582884598998;11947.283163010246;12067.215630983957;12073.818892716792 09:44:39 INFO - PROCESS | 5649 | __end_tp_report 09:44:39 INFO - PROCESS | 5649 | __start_cc_report 09:44:39 INFO - PROCESS | 5649 | _x_x_mozilla_cycle_collect,319 09:44:39 INFO - PROCESS | 5649 | __end_cc_report 09:44:39 INFO - PROCESS | 5649 | __startTimestamp1475081079882__endTimestamp 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | ------- Summary: start ------- 09:44:39 INFO - PROCESS | 5649 | Number of tests: 6 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#0] dojo.html Cycles:165 Average:5410.99 Median:5635.66 stddev:611.07 (10.8%) stddev-sans-first:584.46 09:44:39 INFO - PROCESS | 5649 | Values: 3060.3 3065.5 3070.8 3098.5 3108.9 5336.5 5387.3 5415.2 5457.6 5509.7 5376.4 5400.2 5418.2 5447.3 5489.3 4897.8 4988.4 5012.0 5028.4 5050.9 5041.8 5074.5 5103.2 5135.8 5141.3 4851.8 4883.1 4934.3 4952.6 5002.8 4985.2 4987.1 5034.9 5076.5 5088.0 4948.3 4979.2 4983.2 5005.4 5075.4 5295.0 5328.7 5452.5 5462.3 5470.9 5756.9 5759.1 5768.3 5772.1 5792.7 5778.4 5782.6 5860.9 5862.4 5869.1 5385.0 5434.3 5458.7 5460.8 5460.9 5879.1 5917.4 5925.4 5934.4 6011.3 5660.6 5708.9 5710.5 5712.4 5712.7 5598.0 5775.3 5788.2 5793.7 5847.4 5833.2 5840.2 5846.4 5888.4 5896.6 5851.4 5862.8 5867.6 5867.9 5868.0 4343.2 4389.5 4401.5 4479.3 4492.9 3939.6 3971.6 3989.5 4001.8 4024.0 5472.3 5525.9 5536.3 5541.1 5571.6 5609.0 5655.8 5827.4 5831.4 5839.6 5575.1 5624.0 5636.5 5653.2 5706.7 5066.3 5095.2 5100.8 5101.0 5147.2 5780.2 6082.6 6146.5 6150.5 6152.5 5667.0 5673.7 5724.8 5735.6 5743.7 5917.0 5927.9 5932.8 5941.7 5958.6 5498.1 5616.9 5710.6 5784.4 5797.6 5787.1 5824.4 5828.6 5839.1 5908.7 5714.1 5724.7 5726.0 5729.5 5735.2 5525.3 5572.7 5702.2 5716.3 5750.8 5676.7 5685.9 5688.0 5767.3 5776.9 5702.5 5715.5 5721.5 5722.4 5734.6 5408.8 5451.7 5612.0 5623.6 5635.7 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#1] ext.html Cycles:180 Average:61439.45 Median:41791.48 stddev:126716.75 (303.2%) stddev-sans-first:126989.81 09:44:39 INFO - PROCESS | 5649 | Values: 570.0 575.4 586.9 588.5 599.7 42058.2 44336.6 44371.6 47146.0 47194.0 44209.8 44403.8 44761.6 45035.5 45154.0 8822.3 8906.9 8955.6 8976.9 9009.8 8822.2 8832.6 8844.7 8853.7 8879.6 8838.2 8867.2 8899.5 8917.0 8941.4 8777.0 8780.4 8831.7 8846.7 8858.2 8801.4 8898.3 8901.7 8904.2 8909.2 41764.8 41782.6 41800.4 41884.8 42278.2 3338.5 3345.4 3354.0 3632.9 3773.6 31453.4 31460.7 31573.7 32948.5 33296.3 4217.8 4246.7 4268.6 4290.9 4338.5 335406.0 337283.3 339656.0 339719.0 340305.0 55519.0 56048.7 56055.0 56073.7 56098.2 35496.5 36134.6 59340.7 59394.4 59602.7 13073.0 13299.5 13327.1 13382.9 13470.2 10584.4 10636.6 10657.9 10664.8 10699.4 18368.4 18756.2 18813.0 18825.7 18890.0 6920.3 7061.6 7130.2 7155.7 7436.7 921.9 966.9 1081.8 1136.9 1142.1 32216.0 32532.7 32665.8 32707.8 32904.7 1013.9 1017.0 1032.8 1073.5 1113.1 16020.4 16802.7 16834.5 16869.8 16936.4 598748.0 599330.0 601027.0 610521.0 611501.0 56164.0 56575.4 56625.0 56713.1 56958.1 1257.4 1301.5 1303.6 1309.5 1326.4 29424.0 30378.5 30423.0 31170.7 31516.2 49743.3 49926.3 49955.8 49975.0 50080.0 441619.0 446416.0 447383.0 447731.0 449328.0 27562.0 27868.9 28121.6 28169.4 28269.0 46255.0 46935.8 47060.5 47061.8 48013.8 39625.6 40082.6 40505.4 40969.4 41493.6 39299.4 40527.0 40595.2 41452.8 41878.6 39552.0 40323.4 40348.8 41051.2 41061.5 32983.7 36043.6 36528.6 36581.1 36794.6 27436.6 27767.4 27950.6 28167.0 28237.6 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#2] jquery.html Cycles:180 Average:27481.14 Median:2498.82 stddev:75454.61 (3019.6%) stddev-sans-first:75638.88 09:44:39 INFO - PROCESS | 5649 | Values: 400.0 400.3 405.6 408.4 419.7 17965.8 18592.3 18832.2 19381.3 19385.1 18319.8 18418.9 18497.5 18551.7 18650.8 5649.5 5670.7 5807.9 5823.9 5899.9 5735.7 5763.3 5780.3 5790.8 5809.2 5602.1 5763.4 5765.3 5777.7 5787.6 5725.7 5753.1 5780.6 5802.1 5809.0 5046.1 5089.9 5191.6 5194.7 5199.2 21884.5 21966.1 22009.3 22052.0 22146.7 2304.2 2385.9 2422.2 2575.4 2849.0 13751.8 14155.6 14164.7 14361.8 14470.1 1840.0 1904.4 1936.3 1941.6 1974.8 80115.2 81464.6 81497.2 83178.0 83810.6 9843.5 10177.5 10411.0 10450.6 11277.9 14692.0 14736.0 14776.4 14793.1 14801.8 6838.6 7117.9 7229.8 7334.2 7398.1 6252.6 6320.4 6446.6 6594.9 6774.4 6260.3 6454.1 6481.3 6494.1 6605.5 1904.8 1944.4 1973.7 1980.1 1981.7 849.6 947.4 961.7 1067.1 1072.5 17398.7 18475.5 19161.3 19345.2 19448.0 961.8 967.2 976.0 1026.1 1043.1 10160.5 10801.6 10936.3 10938.2 11037.8 448828.0 449947.0 460893.0 465036.0 465638.0 79697.6 80384.6 80476.2 81763.0 83019.6 1016.2 1033.3 1039.2 1047.2 1049.2 16375.0 16516.3 16708.3 17003.1 17297.4 38258.6 38335.4 39175.8 39309.8 39492.4 51321.0 51970.5 52533.2 52617.5 53713.5 7869.3 7893.5 8016.3 8208.6 8739.3 12608.5 12768.2 12913.6 13221.8 13272.2 10868.4 10909.0 10974.5 10985.7 11519.9 11177.0 11242.2 11254.0 11585.3 11629.6 11171.2 11181.6 11296.0 11362.1 11677.2 7589.7 8185.3 8386.5 8578.1 8584.7 10292.8 10406.8 10483.8 10535.3 10987.5 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#3] mootools.html Cycles:180 Average:5938.30 Median:2628.89 stddev:3446.19 (131.1%) stddev-sans-first:3439.24 09:44:39 INFO - PROCESS | 5649 | Values: 1435.3 1481.0 1630.5 1777.8 1800.5 7636.0 7827.9 8644.4 9390.7 9393.5 8721.1 8933.7 8937.2 9177.4 9196.6 2347.7 2380.1 2409.8 2415.6 2418.6 2323.3 2364.8 2369.9 2371.9 2423.1 2331.0 2342.8 2363.4 2408.1 2408.1 2283.0 2307.2 2313.4 2320.9 2350.7 2275.6 2282.5 2284.7 2289.6 2291.6 9210.6 9351.6 9353.1 9384.3 9399.7 5286.9 5331.0 5360.7 5468.1 5483.4 3356.3 3509.5 3545.5 3572.7 3588.2 1047.8 1079.1 1079.6 1091.4 1107.5 12531.6 12771.6 12779.0 12856.2 12878.9 4790.1 4796.3 4807.6 4839.0 4936.1 10738.4 10764.6 10806.4 10848.5 10852.8 5157.8 5243.8 5267.9 5284.6 5287.7 4122.9 4247.4 4786.0 4824.4 4912.1 3853.5 3936.7 4047.8 4055.6 4205.6 1292.7 1300.7 1306.8 1322.1 1324.0 811.6 869.9 904.9 931.7 932.3 6163.3 6165.1 6195.4 6317.8 6408.5 458.8 467.3 468.0 471.8 920.8 3976.1 4136.6 4176.7 4180.1 4328.3 11171.0 11382.4 11487.5 11490.7 11492.1 11053.0 11275.2 11327.9 11347.3 11424.8 8228.7 8444.6 8510.6 8515.2 8556.4 5806.6 5825.3 5826.5 5858.9 6017.9 10413.2 10501.5 10514.8 10654.0 10703.4 10038.5 10429.1 10572.2 10573.3 10707.1 7673.0 7717.0 7862.3 8426.4 8660.1 7966.2 8380.2 8382.9 8392.2 8399.1 7533.4 7800.9 7855.3 7925.3 8069.0 7654.4 7711.4 7717.2 7837.3 7941.0 7285.5 7445.6 7449.8 7457.6 7466.3 5191.7 5200.9 5310.8 5311.7 5528.7 5253.8 5287.2 5394.3 5414.1 5511.4 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#4] prototype.html Cycles:180 Average:4815.68 Median:5350.79 stddev:1426.15 (26.7%) stddev-sans-first:1389.75 09:44:39 INFO - PROCESS | 5649 | Values: 324.7 331.6 333.7 338.9 344.6 5351.9 5499.9 5545.8 5600.4 5650.6 5268.6 5378.8 5398.6 5408.2 5433.3 4273.2 4291.5 4329.5 4336.7 4345.5 4277.7 4312.5 4364.9 4369.0 4369.7 4287.8 4290.4 4290.5 4297.4 4304.5 4271.3 4299.1 4315.9 4321.2 4336.5 3777.7 3838.9 3867.6 3879.3 3886.9 5265.9 5276.5 5341.5 5344.7 5377.4 4954.8 4957.8 4978.7 4986.7 5007.6 5595.0 5780.7 5788.8 5794.5 5819.6 4160.5 4163.2 4165.3 4165.5 4176.1 5936.6 5951.0 6046.5 6050.3 6061.5 4123.1 4319.2 4319.2 4346.4 4348.0 4306.1 4353.7 4377.1 4379.6 4405.9 4978.1 4981.3 4988.3 4994.3 4995.3 5625.6 5816.0 5841.0 5853.6 5853.7 1487.2 1511.3 1511.9 1514.6 1517.3 928.7 955.9 976.7 978.3 985.2 4915.6 4918.8 4928.8 4932.5 4974.8 5172.3 5234.7 5237.0 5240.3 5280.4 4624.5 4884.5 4919.4 4937.2 4975.9 2741.8 2752.6 2755.5 2760.4 2761.4 5349.7 5357.5 5393.8 5413.0 5448.5 5366.2 5369.6 5754.6 6145.9 6183.3 6119.7 6165.3 6182.4 6224.0 6237.2 5956.9 5981.9 6066.5 6105.1 6111.5 5897.9 5913.7 5925.6 5932.6 6009.5 6251.6 6303.4 6332.2 6340.4 6341.0 4151.9 4281.9 4289.5 4294.6 4303.2 5989.6 6042.4 6054.4 6055.1 6074.7 5641.0 5924.3 5927.0 5932.2 5953.1 5802.4 5821.9 5832.8 5845.9 5848.3 5797.1 5819.9 5836.8 5847.2 5847.3 5777.5 5847.8 5860.7 5872.5 5903.6 5706.7 5751.3 5752.9 5754.9 5786.5 09:44:39 INFO - PROCESS | 5649 | 09:44:39 INFO - PROCESS | 5649 | [#5] yui.html Cycles:180 Average:19604.43 Median:4636.30 stddev:27873.83 (601.2%) stddev-sans-first:27915.82 09:44:39 INFO - PROCESS | 5649 | Values: 683.2 752.3 785.6 794.4 812.9 13484.5 13824.9 15669.6 15732.6 16111.3 14509.6 14781.7 14784.1 14828.3 14841.7 786.8 806.5 809.1 809.2 809.4 784.8 802.1 804.5 812.4 814.5 834.6 843.4 847.5 848.5 850.0 836.8 837.2 839.4 840.6 843.6 621.3 622.0 622.9 623.5 624.3 14277.9 14291.6 14351.8 14357.8 14367.2 13507.6 13636.7 14108.9 14194.6 14267.2 11854.6 11924.9 12009.6 12050.8 12079.2 3716.8 3728.3 3730.0 3746.2 3915.8 83044.6 84108.0 85397.6 85835.6 86095.0 10465.5 10844.0 10990.7 11089.2 11255.2 20202.8 20235.8 20358.0 20365.6 20515.9 7633.3 7966.6 8065.7 8078.0 8147.0 4525.9 4652.9 4711.3 4814.9 4819.5 3310.6 3430.1 3450.7 3457.9 3461.0 606.4 630.1 631.3 647.8 650.1 512.0 600.0 660.6 675.1 684.6 9192.6 9700.2 9740.6 9825.0 9881.9 559.1 658.8 671.7 673.4 678.2 4224.4 4619.7 4662.8 4680.4 4722.3 77554.0 78148.0 92882.0 96804.5 112208.0 100966.5 101048.0 101481.9 102785.5 105343.0 25267.6 25584.4 79204.6 87472.6 88019.6 9196.4 9835.0 9853.0 9950.6 9985.0 49230.5 49325.5 49920.5 51055.2 51312.7 67998.3 68283.7 72329.6 76225.0 77267.0 12095.6 12286.7 12293.4 12854.7 13060.7 14908.9 14918.9 15016.4 15049.8 15252.5 13074.2 14247.3 14498.9 14529.9 14952.9 12886.4 13290.3 13356.7 13380.9 13437.6 11348.5 13328.4 13437.7 14000.3 14271.1 10840.2 11502.4 11547.5 11702.0 11767.2 10908.9 11917.6 11947.3 12067.2 12073.8 09:44:39 INFO - PROCESS | 5649 | -------- Summary: end -------- 09:44:39 INFO - PROCESS | 5649 | 09:44:40 INFO - TEST-INFO | 5649: exit 0 09:44:40 INFO - TEST-OK | dromaeo_css | took 1114819ms 09:44:40 INFO - TEST-START | kraken 09:44:40 INFO - operating with platform_type : linux_ 09:44:40 INFO - Initialising browser for kraken test... 09:44:40 INFO - TEST-INFO | started process 6020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6yOJUA/profile http://localhost:52913/getInfo.html) 09:44:45 INFO - PROCESS | 6020 | __metrics Screen width/height:1600/1200 09:44:45 INFO - PROCESS | 6020 | colorDepth:24 09:44:45 INFO - PROCESS | 6020 | Browser inner width/height: 1024/697 09:44:45 INFO - PROCESS | 6020 | __metrics 09:44:46 ERROR - PROCESS | 6020 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:44:47 INFO - TEST-INFO | 6020: exit 0 09:44:47 INFO - Browser initialized. 09:44:47 INFO - Running cycle 1/1 for kraken test... 09:44:47 INFO - TEST-INFO | started process 6141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6yOJUA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:59 INFO - PROCESS | 6141 | RSS: Main: 185450496 09:44:59 INFO - PROCESS | 6141 | 09:45:02 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-beat-detection) 09:45:03 INFO - PROCESS | 6141 | RSS: Main: 199008256 09:45:03 INFO - PROCESS | 6141 | 09:45:05 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-dft) 09:45:06 INFO - PROCESS | 6141 | RSS: Main: 197087232 09:45:06 INFO - PROCESS | 6141 | 09:45:09 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-fft) 09:45:09 INFO - PROCESS | 6141 | RSS: Main: 192724992 09:45:09 INFO - PROCESS | 6141 | 09:45:12 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52913/tests/kraken/driver.html?testName=audio-oscillator) 09:45:12 INFO - PROCESS | 6141 | RSS: Main: 193404928 09:45:12 INFO - PROCESS | 6141 | 09:45:14 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:45:15 INFO - PROCESS | 6141 | RSS: Main: 193560576 09:45:15 INFO - PROCESS | 6141 | 09:45:18 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-darkroom) 09:45:19 INFO - PROCESS | 6141 | RSS: Main: 193708032 09:45:19 INFO - PROCESS | 6141 | 09:45:22 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52913/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:23 INFO - PROCESS | 6141 | RSS: Main: 191729664 09:45:23 INFO - PROCESS | 6141 | 09:45:26 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52913/tests/kraken/driver.html?testName=json-parse-financial) 09:45:26 INFO - PROCESS | 6141 | RSS: Main: 192925696 09:45:26 INFO - PROCESS | 6141 | 09:45:28 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:28 INFO - PROCESS | 6141 | RSS: Main: 193441792 09:45:28 INFO - PROCESS | 6141 | 09:45:30 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:31 INFO - PROCESS | 6141 | RSS: Main: 193372160 09:45:31 INFO - PROCESS | 6141 | 09:45:33 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:34 INFO - PROCESS | 6141 | RSS: Main: 193986560 09:45:34 INFO - PROCESS | 6141 | 09:45:36 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:37 INFO - PROCESS | 6141 | RSS: Main: 193568768 09:45:37 INFO - PROCESS | 6141 | 09:45:40 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:40 INFO - PROCESS | 6141 | RSS: Main: 193646592 09:45:40 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | Cycle 1(1): loaded http://localhost:52913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52913/tests/kraken/driver.html?testName=ai-astar) 09:45:42 INFO - PROCESS | 6141 | RSS: Main: 195112960 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | __start_tp_report 09:45:42 INFO - PROCESS | 6141 | _x_x_mozilla_page_load 09:45:42 INFO - PROCESS | 6141 | _x_x_mozilla_page_load_details 09:45:42 INFO - PROCESS | 6141 | |i|pagename|runs| 09:45:42 INFO - PROCESS | 6141 | |0;ai-astar;104;113;112;113;114;113;112;114;113;113 09:45:42 INFO - PROCESS | 6141 | |1;audio-beat-detection;150;124;119;165;122;123;127;124;154;120 09:45:42 INFO - PROCESS | 6141 | |2;audio-dft;166;166;163;169;168;162;165;164;166;163 09:45:42 INFO - PROCESS | 6141 | |3;audio-fft;75;77;76;114;77;76;78;76;110;76 09:45:42 INFO - PROCESS | 6141 | |4;audio-oscillator;84;85;113;85;85;84;99;83;83;112 09:45:42 INFO - PROCESS | 6141 | |5;imaging-gaussian-blur;118;118;118;119;119;119;117;122;117;118 09:45:42 INFO - PROCESS | 6141 | |6;imaging-darkroom;147;147;147;147;149;149;146;147;148;147 09:45:42 INFO - PROCESS | 6141 | |7;imaging-desaturate;97;96;96;97;97;96;97;96;96;95 09:45:42 INFO - PROCESS | 6141 | |8;json-parse-financial;52;52;52;51;53;54;53;53;52;53 09:45:42 INFO - PROCESS | 6141 | |9;json-stringify-tinderbox;60;60;61;65;64;61;60;60;60;61 09:45:42 INFO - PROCESS | 6141 | |10;stanford-crypto-aes;81;84;79;79;80;88;79;79;79;78 09:45:42 INFO - PROCESS | 6141 | |11;stanford-crypto-ccm;131;134;124;124;134;134;128;130;168;137 09:45:42 INFO - PROCESS | 6141 | |12;stanford-crypto-pbkdf2;168;164;164;162;168;170;168;163;162;165 09:45:42 INFO - PROCESS | 6141 | |13;stanford-crypto-sha256-iterative;66;67;72;66;67;68;65;67;63;69 09:45:42 INFO - PROCESS | 6141 | __end_tp_report 09:45:42 INFO - PROCESS | 6141 | __start_cc_report 09:45:42 INFO - PROCESS | 6141 | _x_x_mozilla_cycle_collect,737 09:45:42 INFO - PROCESS | 6141 | __end_cc_report 09:45:42 INFO - PROCESS | 6141 | __startTimestamp1475081142734__endTimestamp 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ------- Summary: start ------- 09:45:42 INFO - PROCESS | 6141 | Number of tests: 14 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.92 (2.6%) stddev-sans-first:0.71 09:45:42 INFO - PROCESS | 6141 | Values: 104.0 113.0 112.0 113.0 114.0 113.0 112.0 114.0 113.0 113.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:125.50 stddev:16.79 (13.4%) stddev-sans-first:16.62 09:45:42 INFO - PROCESS | 6141 | Values: 150.0 124.0 119.0 165.0 122.0 123.0 127.0 124.0 154.0 120.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#2] audio-dft Cycles:10 Average:165.20 Median:166.00 stddev:2.25 (1.4%) stddev-sans-first:2.37 09:45:42 INFO - PROCESS | 6141 | Values: 166.0 166.0 163.0 169.0 168.0 162.0 165.0 164.0 166.0 163.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:15.07 (19.8%) stddev-sans-first:15.67 09:45:42 INFO - PROCESS | 6141 | Values: 75.0 77.0 76.0 114.0 77.0 76.0 78.0 76.0 110.0 76.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:84.50 stddev:12.12 (14.3%) stddev-sans-first:12.56 09:45:42 INFO - PROCESS | 6141 | Values: 84.0 85.0 113.0 85.0 85.0 84.0 99.0 83.0 83.0 112.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.43 (1.2%) stddev-sans-first:1.51 09:45:42 INFO - PROCESS | 6141 | Values: 118.0 118.0 118.0 119.0 119.0 119.0 117.0 122.0 117.0 118.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 09:45:42 INFO - PROCESS | 6141 | Values: 147.0 147.0 147.0 147.0 149.0 149.0 146.0 147.0 148.0 147.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:45:42 INFO - PROCESS | 6141 | Values: 97.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 95.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 09:45:42 INFO - PROCESS | 6141 | Values: 52.0 52.0 52.0 51.0 53.0 54.0 53.0 53.0 52.0 53.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.81 (3.0%) stddev-sans-first:1.87 09:45:42 INFO - PROCESS | 6141 | Values: 60.0 60.0 61.0 65.0 64.0 61.0 60.0 60.0 60.0 61.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.10 (3.9%) stddev-sans-first:3.28 09:45:42 INFO - PROCESS | 6141 | Values: 81.0 84.0 79.0 79.0 80.0 88.0 79.0 79.0 79.0 78.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:134.00 stddev:12.58 (9.4%) stddev-sans-first:13.28 09:45:42 INFO - PROCESS | 6141 | Values: 131.0 134.0 124.0 124.0 134.0 134.0 128.0 130.0 168.0 137.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.50 stddev:2.88 (1.7%) stddev-sans-first:2.89 09:45:42 INFO - PROCESS | 6141 | Values: 168.0 164.0 164.0 162.0 168.0 170.0 168.0 163.0 162.0 165.0 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.40 (3.6%) stddev-sans-first:2.52 09:45:42 INFO - PROCESS | 6141 | Values: 66.0 67.0 72.0 66.0 67.0 68.0 65.0 67.0 63.0 69.0 09:45:42 INFO - PROCESS | 6141 | -------- Summary: end -------- 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | 09:45:42 INFO - PROCESS | 6141 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 09:45:42 INFO - PROCESS | 6141 | 09:45:43 INFO - TEST-INFO | 6141: exit 0 09:45:43 INFO - TEST-OK | kraken | took 62951ms 09:45:43 INFO - SUITE-END | took 1177s 09:45:43 INFO - Completed test suite (00:19:37) 09:45:43 INFO - javascript benchmark 09:45:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7232.871638504518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.3267281198137, 3065.4941934580797, 3070.8464576771157, 3098.4732595458763, 3108.8756449741995, 5336.546393556552, 5387.272718183049, 5415.160650099236, 5457.617966742329, 5509.669419834812, 5376.381716102649, 5400.189971504276, 5418.187271909215, 5447.291852059237, 5489.258950041753, 4897.828575999841, 4988.351514303135, 5012.0, 5028.446870844223, 5050.949490505084, 5041.8235361762345, 5074.517920797518, 5103.183490641498, 5135.845924622248, 5141.30592370029, 4851.830185943475, 4883.12103821312, 4934.284528743348, 4952.603791696655, 5002.7743202915335, 4985.202367621163, 4987.077390682735, 5034.949650503485, 5076.466970968069, 5088.0, 4948.307236986825, 4979.153543897546, 4983.227599722049, 5005.449400565934, 5075.390953085654, 5294.973525132388, 5328.733563321818, 5452.454754524555, 5462.344518657746, 5470.9452905470835, 5756.942430575725, 5759.078547432433, 5768.278965129359, 5772.134179873053, 5792.739326730307, 5778.3643799182055, 5782.56630752691, 5860.912086318709, 5862.355140934494, 5869.060950247983, 5385.030694475032, 5434.266374039494, 5458.727063646802, 5460.808871689472, 5460.890782184334, 5879.059350503899, 5917.378675239038, 5925.4370834770625, 5934.43622855828, 6011.27864656244, 5660.575456840671, 5708.885822283614, 5710.486056254957, 5712.371639119693, 5712.714364281853, 5598.0, 5775.27809023872, 5788.160716696139, 5793.710314484259, 5847.38602446737, 5833.154192642043, 5840.1531777892815, 5846.386129456431, 5888.352281249059, 5896.587238893322, 5851.38560451155, 5862.794802181988, 5867.618604790675, 5867.911981320283, 5868.031774757117, 4343.2182207203, 4389.517153113155, 4401.471823381215, 4479.328100784908, 4492.932606010912, 3939.5666476687543, 3971.602839716063, 3989.501312335958, 4001.7598944063448, 4024.014116541466, 5472.288602481652, 5525.944740552543, 5536.335639723259, 5541.141123125922, 5571.554275657938, 5609.0, 5655.830325090172, 5827.388124246978, 5831.3877042910735, 5839.649621022752, 5575.0522411190195, 5624.0439125348785, 5636.520895723827, 5653.208550802891, 5706.743196556165, 5066.341375621146, 5095.159298715745, 5100.770465329069, 5101.005303965765, 5147.1507201312115, 5780.190773291826, 6082.615514776056, 6146.477549408351, 6150.50795936324, 6152.538559608047, 5667.0, 5673.730607366154, 5724.799632013026, 5735.569832262514, 5743.655380677173, 5916.970415147896, 5927.881442371215, 5932.762689492372, 5941.673207973603, 5958.553108516792, 5498.065328894178, 5616.887662246814, 5710.628809127394, 5784.392638772868, 5797.594168408171, 5787.074068149076, 5824.417558244311, 5828.59199856006, 5839.124131380327, 5908.734106965283, 5714.114312281603, 5724.713764311851, 5726.026575482261, 5729.4843464088435, 5735.168400581809, 5525.336959564878, 5572.665640061609, 5702.201691763239, 5716.342620598684, 5750.769969201185, 5676.659400435987, 5685.914711279417, 5688.004599195042, 5767.250257466502, 5776.913346299725, 5702.486776190163, 5715.485606295453, 5721.5136713379825, 5722.4277572242445, 5734.569907256889, 5408.8377348679605, 5451.700156491431, 5612.045952188219, 5623.606347555632, 5635.6618602883955], "value": 5369.242939506779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9715014249288, 575.3987083497744, 586.8503531599441, 588.4674369695427, 599.6581948289476, 42058.15883682325, 44336.556634433684, 44371.55628443719, 47146.0, 47194.0, 44209.778951105196, 44403.77798111013, 44761.55238447615, 45035.549644503546, 45154.0, 8822.294216462684, 8906.86639700405, 8955.596998135066, 8976.8653470198, 9009.819803603925, 8822.161894620001, 8832.602532886003, 8844.73465796024, 8853.690120845771, 8879.600417981173, 8838.204561589455, 8867.24628406583, 8899.510526921016, 8917.0, 8941.374103812735, 8776.956115219415, 8780.385373023892, 8831.69089081879, 8846.734597962039, 8858.247049000842, 8801.383903126783, 8898.288136949028, 8901.688440904538, 8904.198622123975, 8909.242714369286, 41764.79117604423, 41782.58217417818, 41800.37299440511, 41884.79057604723, 42278.15443691109, 3338.5159151923076, 3345.414552453311, 3353.96646033539, 3632.909177270563, 3773.64150405711, 31453.37093258145, 31460.685393146003, 31573.684263157535, 32948.50577241343, 33296.3340733184, 4217.8312867485265, 4246.745195288293, 4268.622498349988, 4290.935635965432, 4338.501072376685, 335406.0, 337283.313583433, 339656.0, 339719.0, 340305.0, 55519.0, 56048.719756400955, 56055.0, 56073.71963140158, 56098.1585276213, 35496.46755298621, 36134.638653613125, 59340.70329648324, 59394.40605593889, 59602.70198648979, 13072.973689078208, 13299.46802127904, 13327.067105302536, 13382.866171338357, 13470.191788492722, 10584.417857017785, 10636.627718029831, 10657.893421065844, 10664.840027399596, 10699.411532365639, 18368.448946531626, 18756.249750009847, 18813.0, 18825.717614235797, 18890.0, 6920.342567456084, 7061.576305421691, 7130.180029296594, 7155.713771449084, 7436.702531898772, 921.9032001639865, 966.8673497866861, 1081.7728277061747, 1136.86926003509, 1142.1269118645428, 32216.0, 32532.674673252965, 32665.83667081697, 32707.836460817543, 32904.67095329016, 1013.9239557033252, 1016.9644062457778, 1032.7521394865178, 1073.5061871539178, 1113.1484414422973, 16020.359185632677, 16802.747958780383, 16834.494965151065, 16869.83130168707, 16936.40722574704, 598748.0, 599330.0, 601027.0, 610521.0, 611501.0, 56164.0, 56575.43424565784, 56625.0, 56713.06017157518, 56958.14562781562, 1257.3713143428286, 1301.5184381778613, 1303.5633062923837, 1309.5023890921389, 1326.3699742622177, 29424.0, 30378.54432183563, 30423.0, 31170.68829311678, 31516.212094697818, 49743.25385119298, 49926.25110623271, 49955.75022124866, 49975.0, 50080.0, 441619.0, 446416.0, 447383.0, 447731.0, 449328.0, 27562.0, 27868.860655696593, 28121.578176326962, 28169.43661126807, 28269.0, 46255.0, 46935.765321173174, 47060.52939470561, 47061.76469117632, 48013.75993120012, 39625.603743962194, 40082.59917400789, 40505.43350988314, 40969.38545921754, 41493.58506415018, 39299.410508842964, 40527.0, 40595.188096238504, 41452.79273603613, 41878.58121418747, 39552.0, 40323.3951490722, 40348.79825600853, 41051.1789764209, 41061.48323684333, 32983.67016329902, 36043.63956360508, 36528.63471365252, 36581.08547286339, 36794.63205367912, 27436.58845117285, 27767.444651107267, 27950.58074128849, 28167.0, 28237.57643635306], "value": 19666.46744243851, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.9520057593089, 400.3014739279956, 405.6065616352137, 408.3935355996345, 419.73346924702804, 17965.820341796578, 18592.34926777563, 18832.246710131614, 19381.32165374214, 19385.12766925488, 18319.816801831978, 18418.907905460455, 18497.537561560966, 18551.721724174113, 18650.813491865076, 5649.519790817785, 5670.68811215382, 5807.883842323151, 5823.854403639922, 5899.852503687421, 5735.655860648374, 5763.279590051244, 5780.335261444925, 5790.826275211751, 5809.215755872967, 5602.1036634138545, 5763.39484354143, 5765.308163020443, 5777.653340799545, 5787.565932555054, 5725.685087320196, 5753.079507278836, 5780.624259423124, 5802.100674395476, 5808.970955145219, 5046.142155833517, 5089.872753181163, 5191.610629202787, 5194.68831870089, 5199.194124910645, 21884.45288867775, 21966.121355145777, 22009.33971980843, 22052.0, 22146.667799983014, 2304.182015384531, 2385.880705964712, 2422.219668543619, 2575.420530380668, 2849.0313293480317, 13751.793723094162, 14155.575332740034, 14164.716705665933, 14361.784573231409, 14470.131792092508, 1839.9774211597303, 1904.3810761502566, 1936.3295136337501, 1941.631090092878, 1974.8123928226796, 80115.19596814142, 81464.59267703682, 81497.18502815014, 83178.0, 83810.58094709548, 9843.507824608741, 10177.491125443697, 10411.0, 10450.634227801991, 11277.913585986618, 14692.0, 14736.0, 14776.408943642135, 14793.11241325524, 14801.777973330409, 6838.623875686885, 7117.92882071183, 7229.783106506813, 7334.156571994289, 7398.149212840484, 6252.624842509373, 6320.399562041599, 6446.645434501147, 6594.901076483857, 6774.390304872585, 6260.342664020212, 6454.059610481049, 6481.254655714653, 6494.1232933553365, 6605.504587155887, 1904.7619047619048, 1944.397236856579, 1973.6644770389069, 1980.069367397321, 1981.6928376101728, 849.5582297205418, 947.3747326764302, 961.6778379243032, 1067.0503252105632, 1072.453048945028, 17398.65202695939, 18475.538111547317, 19161.32935347256, 19345.226190952206, 19448.0, 961.7595601099725, 967.1730670276953, 976.0483528559597, 1026.14829691356, 1043.0768769638773, 10160.4919754012, 10801.594067847116, 10936.289141205796, 10938.179636527293, 11037.779244415067, 448828.0, 449947.0, 460893.0, 465036.0, 465638.0, 79697.60151199206, 80384.59807700924, 80476.1714297144, 81763.0, 83019.5849020751, 1016.2479764974014, 1033.2818691009677, 1039.2361614213546, 1047.1884289675563, 1049.1763965287366, 16375.0, 16516.256768445208, 16708.331666733193, 17003.06483143439, 17297.394591189248, 38258.61741382551, 38335.42496862494, 39175.80412097921, 39309.80345098256, 39492.40761388639, 51321.0, 51970.48029519656, 52533.212001820764, 52617.47382526126, 53713.46286537085, 7869.331106855752, 7893.486923349964, 8016.318612917734, 8208.58957052133, 8739.300855931637, 12608.49566017349, 12768.233905965672, 12913.612591622266, 13221.801672975105, 13272.203667779964, 10868.402237876993, 10909.0, 10974.506147223554, 10985.725356865823, 11519.88480115188, 11177.046494435337, 11242.156838237, 11254.043406310555, 11585.304881707125, 11629.59296424621, 11171.218014739216, 11181.552737890393, 11296.0, 11362.14783891228, 11677.240979336317, 7589.696412143452, 8185.263326300424, 8386.538740369338, 8578.099299573705, 8584.699535516227, 10292.794144117226, 10406.843897341394, 10483.842742359024, 10535.262531623019, 10987.505562249878], "value": 9078.112382352301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.2751860310539, 1480.9703805923882, 1630.494546690526, 1777.8222177782216, 1800.522861441718, 7636.0, 7827.882581761278, 8644.39489235753, 9390.718278451648, 9393.483358415293, 8721.127887211276, 8933.731988040368, 8937.195652391283, 9177.403468774542, 9196.632134714604, 2347.6595893595418, 2380.071772008918, 2409.795167410772, 2415.625578035407, 2418.613021916494, 2323.3030090972725, 2364.775346342095, 2369.857808531485, 2371.893264803088, 2423.115562819567, 2331.0326214620914, 2342.824288178385, 2363.444590521226, 2408.0608562660577, 2408.084927727461, 2282.9657555136687, 2307.215546714117, 2313.398516385735, 2320.9419764505938, 2350.717913850332, 2275.601769690314, 2282.4864405508793, 2284.725832900046, 2289.645105008726, 2291.598970180212, 9210.585523651453, 9351.579178936965, 9353.11145441182, 9384.343095983284, 9399.71800845969, 5286.867828304285, 5330.973345133289, 5360.731963401853, 5468.125099983983, 5483.396826349099, 3356.2951780126205, 3509.5437593112733, 3545.5213546171194, 3572.732045096602, 3588.2464682416726, 1047.8271085270922, 1079.1474734959372, 1079.578964203961, 1091.4488183467377, 1107.501624269074, 12531.561395351118, 12771.552995645108, 12779.0, 12856.228626282453, 12878.87121128786, 4790.137775200427, 4796.25658023007, 4807.591354734886, 4838.975805121022, 4936.111499929975, 10738.355698658106, 10764.56941722338, 10806.35161890289, 10848.457577121113, 10852.837207441895, 5157.819476318386, 5243.764030618631, 5267.868303292448, 5284.5772338212855, 5287.68273903567, 4122.855700050483, 4247.405363249148, 4785.952140478551, 4824.445188803263, 4912.091263116335, 3853.537575490959, 3936.6653834423823, 4047.757134571876, 4055.5538890721996, 4205.600467955539, 1292.7156025674337, 1300.681333073403, 1306.8366454193226, 1322.08115359824, 1324.0069947539346, 811.6185392865344, 869.8782170496136, 904.8733177355175, 931.669257413622, 932.3195812040384, 6163.291221509494, 6165.136880836686, 6195.4424101831055, 6317.842053948688, 6408.455281301049, 458.7843713454671, 467.264059106908, 467.9508651591602, 471.82542459290283, 920.7744102694883, 3976.1451287973223, 4136.565660605654, 4176.749395036247, 4180.059486615487, 4328.285832837547, 11171.0, 11382.373969431761, 11487.483063262172, 11490.712732181762, 11492.080633549296, 11053.0, 11275.154363422776, 11327.943360283145, 11347.262427942158, 11424.771504569862, 8228.711995080263, 8444.61999210037, 8510.617022234015, 8515.191056849713, 8556.443831150955, 5806.564507662027, 5825.300963884361, 5826.533877289722, 5858.912116318344, 6017.939820601913, 10413.219008574235, 10501.527431265458, 10514.78970420572, 10654.0, 10703.411312377893, 10038.548265327932, 10429.12275790365, 10572.202725536523, 10573.312734672221, 10707.089897358812, 7672.961635191788, 7717.0, 7862.253085956825, 8426.41015128935, 8660.09069047741, 7966.203379662219, 8380.24577788002, 8382.874256886274, 8392.16078392156, 8399.076101628938, 7533.3973282138395, 7800.921990780246, 7855.293023627901, 7925.326347260548, 8069.031716194094, 7654.425918056057, 7711.38308935295, 7717.1896950819355, 7837.333826624801, 7940.960295198487, 7285.453590980804, 7445.627718614156, 7449.813754656177, 7457.627118643937, 7466.290702383265, 5191.662541934762, 5200.947990520046, 5310.7875684973715, 5311.654742441729, 5528.695921724344, 5253.842384728464, 5287.206918962186, 5394.271773310553, 5414.10667239901, 5511.448855114457], "value": 4657.685225177826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.70938510033534, 331.63685764088314, 333.7046713658412, 338.8847791750805, 344.5864962045546, 5351.892962140755, 5499.890002199963, 5545.77816887324, 5600.439956004403, 5650.604457687963, 5268.578513718903, 5378.811741589046, 5398.569379114538, 5408.215808707735, 5433.266509021281, 4273.230818452677, 4291.527931927485, 4329.458817647794, 4336.65306775458, 4345.521992580813, 4277.679174061942, 4312.504062032859, 4364.934525982113, 4368.956310436903, 4369.715968462056, 4287.8070486828165, 4290.420793192926, 4290.4851417829905, 4297.419848320484, 4304.504981927087, 4271.316589345721, 4299.140171965604, 4315.870523884289, 4321.157374311994, 4336.460556502428, 3777.697784177259, 3838.865639702597, 3867.588330259463, 3879.301725689375, 3886.863959761423, 5265.947340526584, 5276.498732620395, 5341.545968592674, 5344.6793192408195, 5377.4084850666395, 4954.777035033432, 4957.7769000395065, 4978.6514943953935, 4986.700797952134, 5007.624428167902, 5595.048841696881, 5780.745509251396, 5788.82633520995, 5794.5074668653215, 5819.621724587888, 4160.5007399112, 4163.208990291835, 4165.312723400635, 4165.479315085614, 4176.14389050247, 5936.614120082224, 5950.97024514879, 6046.486048685911, 6050.334463209044, 6061.454469097803, 4123.134141830189, 4319.222539942778, 4319.222539942841, 4346.434963454731, 4347.956520434818, 4306.1172459645695, 4353.717008394444, 4377.102693947733, 4379.642310883636, 4405.889852753643, 4978.054169707744, 4981.252812078217, 4988.301637770715, 4994.275830004702, 4995.275685025724, 5625.606207565431, 5816.0, 5840.984860223216, 5853.590248682552, 5853.678047707332, 1487.2043456750587, 1511.3274592806315, 1511.8866085043667, 1514.5759187427318, 1517.339957118657, 928.6656803550717, 955.8996305387973, 976.682578162086, 978.2614126334714, 985.1773768903046, 4915.648196745852, 4918.827841025547, 4928.753562321941, 4932.482089380564, 4974.751262436864, 5172.250023746611, 5234.685918844882, 5237.029786043837, 5240.292560504359, 5280.419153893069, 4624.468186158568, 4884.511548845087, 4919.434265059564, 4937.235148316954, 4975.900481990412, 2741.849198294113, 2752.605233446914, 2755.531559634827, 2760.3651160233258, 2761.351082495612, 5349.683196418246, 5357.491038351351, 5393.83818485446, 5412.995787337986, 5448.528897197734, 5366.195070739421, 5369.624126311199, 5754.625949313281, 6145.877082458326, 6183.288921774054, 6119.694015299217, 6165.260168779685, 6182.350853160354, 6223.96888015557, 6237.189165408558, 5956.940430595639, 5981.880362392815, 6066.514678825772, 6105.13058862334, 6111.541634377529, 5897.882042359214, 5913.728548362123, 5925.585209035498, 5932.644041357532, 6009.489193418608, 6251.624902505864, 6303.36966303366, 6332.2454732191645, 6340.365963403623, 6341.0, 4151.937720934128, 4281.871543853689, 4289.469213164248, 4294.634956028773, 4303.160883627663, 5989.610675306091, 6042.401767240129, 6054.394560544087, 6055.122007308827, 6074.726637301421, 5641.0, 5924.289085309791, 5927.0, 5932.228810254639, 5953.077273022688, 5802.448767367094, 5821.854453638693, 5832.795852145155, 5845.912311315419, 5848.2689663792025, 5797.130430435468, 5819.883602328015, 5836.766529338949, 5847.152162936265, 5847.298324201123, 5777.50891174238, 5847.80120075375, 5860.677662728591, 5872.500837428866, 5903.645781253139, 5706.743196556082, 5751.252337196138, 5752.942470575241, 5754.913676294943, 5786.479216870502], "value": 4359.454221410758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.2074793239843, 752.2740555364076, 785.579714852554, 794.3864685185738, 812.8902598149256, 13484.460621575137, 13824.926261060833, 15669.608259793511, 15732.60668483287, 16111.274992625331, 14509.637259068502, 14781.704365912703, 14784.112953222813, 14828.332725027372, 14841.703165936702, 786.8072322281049, 806.4838503357827, 809.1221025187679, 809.2352726673296, 809.4455298120777, 784.7606480023591, 802.1096582793095, 804.4770898915693, 812.3663542436909, 814.5153633588005, 834.586879494651, 843.4053991935671, 847.5084451018395, 848.4909054567241, 850.0394554153797, 836.8117173635944, 837.1586555511702, 839.4207996482438, 840.6469282901196, 843.6288033265405, 621.3258614403378, 621.9751209951596, 622.9314775374705, 623.5198896849446, 624.3132554190399, 14277.928610356881, 14291.642708932255, 14351.78472322916, 14357.78463323051, 14367.209803460806, 13507.594772156852, 13636.659083522893, 14108.929455352658, 14194.574162775134, 14267.215303158322, 11854.585089521825, 11924.940375298069, 12009.639710808602, 12050.819237711441, 12079.214851034743, 3716.7955762433057, 3728.254349130185, 3729.981350093259, 3746.1758413149337, 3915.7846318452475, 83044.58477707572, 84108.0, 85397.57301213517, 85835.57082214548, 86095.0, 10465.529051192714, 10844.0, 10990.670279891616, 11089.168312376443, 11255.212135150625, 20202.797972020093, 20235.797642023685, 20358.0, 20365.592688146153, 20515.897420512803, 7633.274838890296, 7966.561839098789, 8065.717699880476, 8077.959610202029, 8146.959265203636, 4525.909481810345, 4652.860414187579, 4711.269753188261, 4814.903701926012, 4819.542143496362, 3310.6027276726463, 3430.125318043883, 3450.6721861423125, 3457.913552161216, 3461.0, 606.369375849112, 630.076937286877, 631.3434028610194, 647.7862305439194, 650.1320736816309, 512.0484910911495, 599.9670018149044, 660.6069388713707, 675.1391975231619, 684.5752611738867, 9192.58633361487, 9700.175485083846, 9740.610375584898, 9825.0, 9881.901180988241, 559.1249694228519, 658.8188248231775, 671.7078071039114, 673.4275865514273, 678.1827897383641, 4224.429701990192, 4619.745913974763, 4662.7668616569035, 4680.438347398334, 4722.291656251589, 77554.0, 78148.0, 92882.0, 96804.51597741967, 112208.0, 100966.4951675237, 101048.0, 101481.8518148194, 102785.48607257065, 105343.0, 25267.62098568523, 25584.36039099, 79204.62386128426, 87472.5626371864, 88019.55990220008, 9196.35625506208, 9834.950825245827, 9853.0, 9950.601975921172, 9984.950075249577, 49230.50769492259, 49325.50674493209, 49920.50079499158, 51055.234171486714, 51312.74343628258, 67998.3200167992, 68283.65858170677, 72329.63835180791, 76225.0, 77267.0, 12095.637130886087, 12286.692832679255, 12293.385330733248, 12854.742905142031, 13060.738785224052, 14908.925455372653, 14918.925405372904, 15016.399344026117, 15049.774253386428, 15252.466163684217, 13074.215547067206, 14247.287635618384, 14498.927505362406, 14529.927350363181, 14952.925235373754, 12886.355682216039, 13290.335483225994, 13356.666083347995, 13380.866191338351, 13437.596872093853, 11348.489317980875, 13328.40022198984, 13437.731245375233, 14000.299985000505, 14271.072380295247, 10840.241183117107, 11502.424878756196, 11547.538098476303, 11702.0, 11767.176297659424, 10908.945455272673, 11917.582884598998, 11947.283163010246, 12067.215630983957, 12073.818892716792], "value": 7355.037348926017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 119.0, 165.0, 122.0, 123.0, 127.0, 124.0, 154.0, 120.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 163.0, 169.0, 168.0, 162.0, 165.0, 164.0, 166.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 114.0, 77.0, 76.0, 78.0, 76.0, 110.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 85.0, 85.0, 84.0, 99.0, 83.0, 83.0, 112.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 117.0, 122.0, 117.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 149.0, 146.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 53.0, 54.0, 53.0, 53.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 65.0, 64.0, 61.0, 60.0, 60.0, 60.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 79.0, 79.0, 80.0, 88.0, 79.0, 79.0, 79.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 124.0, 124.0, 134.0, 134.0, 128.0, 130.0, 168.0, 137.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 164.0, 162.0, 168.0, 170.0, 168.0, 163.0, 162.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 72.0, 66.0, 67.0, 68.0, 65.0, 67.0, 63.0, 69.0], "value": 67.0, "unit": "score"}]}]} 09:45:43 INFO - Return code: 0 09:45:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:44 ERROR - # TBPL SUCCESS # 09:45:44 INFO - Running post-action listener: _resource_record_post_action 09:45:44 INFO - [mozharness: 2016-09-28 16:45:44.032949Z] Finished run-tests step (success) 09:45:44 INFO - Running post-run listener: _resource_record_post_run 09:45:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 398123008; Read time: 0; Write time: 247476 09:45:44 INFO - TinderboxPrint: CPU usage
13.4% 09:45:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:45:44 INFO - TinderboxPrint: I/O write bytes / time
398,123,008 / 247,476 09:45:44 INFO - TinderboxPrint: CPU idle
8,250.0 (86.6%) 09:45:44 INFO - TinderboxPrint: CPU user
1,218.0 (12.8%) 09:45:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109457408; Read time: 0; Write time: 82168 09:45:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288665600; Read time: 0; Write time: 165308 09:45:44 INFO - Running post-run listener: _upload_blobber_files 09:45:44 INFO - Blob upload gear active. 09:45:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:44 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 09:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:45:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:45 INFO - (blobuploader) - INFO - Done attempting. 09:45:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:50 INFO - (blobuploader) - INFO - Done attempting. 09:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:51 INFO - (blobuploader) - INFO - Done attempting. 09:45:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:51 INFO - Return code: 0 09:45:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4dca72dd05780de7f152c14793aa851761f1c56a27bd7eb63e26846730e313dab24f139a707b78988a52cce812294fbd46c809c63983f560b3ab03841156589", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d9bb3451675e45cd603e83450c5a75613c2686bcfbd444149756dbad9ac439da58b19e57a1d1da1e7d1d02e9836aff12edeb9193c4fbb1e020edc222ceab0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04e37c13a8856f1093b53c965af4e0d4ec513138c23ed8ecb531b6ffe12e6ab8dd804d0ebc1d628db9dda23a6ecd7fc257aa6d983e7e63543f5253cc0e98de0"} 09:45:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:51 INFO - Contents: 09:45:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4dca72dd05780de7f152c14793aa851761f1c56a27bd7eb63e26846730e313dab24f139a707b78988a52cce812294fbd46c809c63983f560b3ab03841156589", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d9bb3451675e45cd603e83450c5a75613c2686bcfbd444149756dbad9ac439da58b19e57a1d1da1e7d1d02e9836aff12edeb9193c4fbb1e020edc222ceab0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04e37c13a8856f1093b53c965af4e0d4ec513138c23ed8ecb531b6ffe12e6ab8dd804d0ebc1d628db9dda23a6ecd7fc257aa6d983e7e63543f5253cc0e98de0"} 09:45:51 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:51 INFO - Copying logs to upload dir... 09:45:51 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.068655 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-28 09:45:50.132436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:50.135589) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 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/Fx-Team/sha512/c4dca72dd05780de7f152c14793aa851761f1c56a27bd7eb63e26846730e313dab24f139a707b78988a52cce812294fbd46c809c63983f560b3ab03841156589", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d9bb3451675e45cd603e83450c5a75613c2686bcfbd444149756dbad9ac439da58b19e57a1d1da1e7d1d02e9836aff12edeb9193c4fbb1e020edc222ceab0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04e37c13a8856f1093b53c965af4e0d4ec513138c23ed8ecb531b6ffe12e6ab8dd804d0ebc1d628db9dda23a6ecd7fc257aa6d983e7e63543f5253cc0e98de0"} build_url:https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Fr2A_LMARg60waVqGT1BBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4dca72dd05780de7f152c14793aa851761f1c56a27bd7eb63e26846730e313dab24f139a707b78988a52cce812294fbd46c809c63983f560b3ab03841156589", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d9bb3451675e45cd603e83450c5a75613c2686bcfbd444149756dbad9ac439da58b19e57a1d1da1e7d1d02e9836aff12edeb9193c4fbb1e020edc222ceab0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04e37c13a8856f1093b53c965af4e0d4ec513138c23ed8ecb531b6ffe12e6ab8dd804d0ebc1d628db9dda23a6ecd7fc257aa6d983e7e63543f5253cc0e98de0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:50.163272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:50.163607) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1475079903.709130-1093793747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 09:45:50.245947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 09:45:50.249305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 09:45:50.249598) ========= ========= Total master_lag: 0.17 =========