builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1490899241.95 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.948361) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.948726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.948994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.975311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.975573) ========= 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=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 11:40:42-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-03-30 11:40:42 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.068527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.068842) ========= 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=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.118195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 11:40:42.118555) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --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=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 11:40:42,478 truncating revision to first 12 chars 2017-03-30 11:40:42,478 Setting DEBUG logging. 2017-03-30 11:40:42,478 attempt 1/10 2017-03-30 11:40:42,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 11:40:43,715 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 11:40:43.682235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:43.682559) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:43.682963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:43.683248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:43.691932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-30 11:40:43.692336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:44 INFO - MultiFileLogger online at 20170330 11:40:44 in /builds/slave/test 11:40:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:40:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:44 INFO - {'append_to_log': False, 11:40:44 INFO - 'base_work_dir': '/builds/slave/test', 11:40:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:40:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:44 INFO - 'branch': 'Firefox-Non-PGO', 11:40:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:44 INFO - 'config_files': ('talos/linux_config.py',), 11:40:44 INFO - 'default_actions': ('clobber', 11:40:44 INFO - 'read-buildbot-config', 11:40:44 INFO - 'download-and-extract', 11:40:44 INFO - 'populate-webroot', 11:40:44 INFO - 'create-virtualenv', 11:40:44 INFO - 'install', 11:40:44 INFO - 'run-tests'), 11:40:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:44 INFO - 'download_minidump_stackwalk': True, 11:40:44 INFO - 'download_symbols': 'ondemand', 11:40:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:44 INFO - 'gecko_profile': False, 11:40:44 INFO - 'gecko_profile_interval': 0, 11:40:44 INFO - 'installer_path': 'installer.exe', 11:40:44 INFO - 'log_level': 'info', 11:40:44 INFO - 'log_name': 'talos', 11:40:44 INFO - 'log_to_console': True, 11:40:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:44 INFO - 'opt_config_files': (), 11:40:44 INFO - 'pip_index': False, 11:40:44 INFO - 'suite': 'dromaeojs-e10s', 11:40:44 INFO - 'system_bits': '32', 11:40:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:44 INFO - 'title': 'talos-linux64-ix-028', 11:40:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:44 INFO - 'use_talos_json': True, 11:40:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:44 INFO - 'work_dir': 'build'} 11:40:44 INFO - [mozharness: 2017-03-30 18:40:44.145314Z] Running clobber step. 11:40:44 INFO - Running pre-action listener: _resource_record_pre_action 11:40:44 INFO - Running main action method: clobber 11:40:44 INFO - rmtree: /builds/slave/test/build 11:40:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:45 INFO - Running post-action listener: _resource_record_post_action 11:40:45 INFO - [mozharness: 2017-03-30 18:40:45.585746Z] Finished clobber step (success) 11:40:45 INFO - [mozharness: 2017-03-30 18:40:45.585845Z] Running read-buildbot-config step. 11:40:45 INFO - Running pre-action listener: _resource_record_pre_action 11:40:45 INFO - Running main action method: read_buildbot_config 11:40:45 INFO - Using buildbot properties: 11:40:45 INFO - { 11:40:45 INFO - "project": "", 11:40:45 INFO - "product": "firefox", 11:40:45 INFO - "who": "cbook@mozilla.com", 11:40:45 INFO - "installer_path": "public/build/target.tar.bz2", 11:40:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:40:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:40:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:40:45 INFO - "stage_platform": "linux64", 11:40:45 INFO - "basedir": "/builds/slave/test", 11:40:45 INFO - "buildnumber": 778, 11:40:45 INFO - "platform": "ubuntu64_hw", 11:40:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:40:45 INFO - "slavebuilddir": "test", 11:40:45 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 11:40:45 INFO - "branch": "mozilla-central", 11:40:45 INFO - "script_repo_revision": "production", 11:40:45 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 11:40:45 INFO - "slavename": "talos-linux64-ix-028", 11:40:45 INFO - "repo_path": "mozilla-central" 11:40:45 INFO - } 11:40:45 INFO - Finding installer, test and symbols from parent task. 11:40:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 11:40:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 11:40:46 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 11:40:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 11:40:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:40:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 11:40:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 11:40:46 INFO - Running post-action listener: _resource_record_post_action 11:40:46 INFO - [mozharness: 2017-03-30 18:40:46.980140Z] Finished read-buildbot-config step (success) 11:40:46 INFO - [mozharness: 2017-03-30 18:40:46.980358Z] Running download-and-extract step. 11:40:46 INFO - Running pre-action listener: _resource_record_pre_action 11:40:46 INFO - Running main action method: download_and_extract 11:40:46 INFO - mkdir: /builds/slave/test/build/tests 11:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:46 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 11:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:40:47 INFO - Downloaded 986 bytes. 11:40:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:40:47 INFO - Using the following test package requirements: 11:40:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:40:47 INFO - u'common': [u'target.common.tests.zip'], 11:40:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:40:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:40:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:40:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:40:47 INFO - u'mozbase': [u'target.common.tests.zip'], 11:40:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:40:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:40:47 INFO - u'web-platform': [u'target.common.tests.zip', 11:40:47 INFO - u'target.web-platform.tests.zip'], 11:40:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:40:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:40:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 11:40:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:40:47 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 11:40:48 INFO - Expected file size: 58227794 11:40:48 INFO - Obtained file size: 58227794 11:40:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:40:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 11:40:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:40:58 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 11:40:59 INFO - Expected file size: 58227794 11:40:59 INFO - Obtained file size: 58227794 11:41:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 11:41:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:41:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 11:41:10 INFO - Expected file size: 14404152 11:41:10 INFO - Obtained file size: 14404152 11:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:11 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:41:12 INFO - Downloaded 62478421 bytes. 11:41:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:12 INFO - mkdir: /builds/slave/test/properties 11:41:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:41:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:41:12 INFO - Contents: 11:41:12 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:12 INFO - Running post-action listener: _resource_record_post_action 11:41:12 INFO - Running post-action listener: set_extra_try_arguments 11:41:12 INFO - [mozharness: 2017-03-30 18:41:12.400282Z] Finished download-and-extract step (success) 11:41:12 INFO - [mozharness: 2017-03-30 18:41:12.400378Z] Running populate-webroot step. 11:41:12 INFO - Running pre-action listener: _resource_record_pre_action 11:41:12 INFO - Running main action method: populate_webroot 11:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:41:12 INFO - '--tppagecycles', 11:41:12 INFO - '7'], 11:41:12 INFO - 'tests': ['tsvgm']}}, 11:41:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:41:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:41:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:41:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:41:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['damp', 'tps']}, 11:41:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'tests': ['damp', 'tps']}, 11:41:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['dromaeo_dom']}, 11:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:41:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['basic_compositor_video']}, 11:41:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:41:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['a11yr', 11:41:12 INFO - 'ts_paint', 11:41:12 INFO - 'tpaint', 11:41:12 INFO - 'sessionrestore', 11:41:12 INFO - 'sessionrestore_no_auto_restore', 11:41:12 INFO - 'tabpaint']}, 11:41:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['tsvgx', 11:41:12 INFO - 'tsvgr_opacity', 11:41:12 INFO - 'tart', 11:41:12 INFO - 'tscrollx', 11:41:12 INFO - 'cart', 11:41:12 INFO - 'tsvg_static']}, 11:41:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:41:12 INFO - 'tsvgr_opacity', 11:41:12 INFO - 'tart', 11:41:12 INFO - 'tscrollx', 11:41:12 INFO - 'cart', 11:41:12 INFO - 'tsvg_static']}, 11:41:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'talos_options': ['--disable-e10s'], 11:41:12 INFO - 'tests': ['tp5o']}, 11:41:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:41:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'talos_options': ['--disable-e10s', 11:41:12 INFO - '--xperf_path', 11:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:12 INFO - 'tests': ['tp5n']}, 11:41:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:41:12 INFO - 'talos_options': ['--xperf_path', 11:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:12 INFO - 'tests': ['tp5n']}}, 11:41:12 INFO - 'talos.zip': {'path': '', 11:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:41:12 INFO - Running post-action listener: _resource_record_post_action 11:41:12 INFO - [mozharness: 2017-03-30 18:41:12.413568Z] Finished populate-webroot step (success) 11:41:12 INFO - [mozharness: 2017-03-30 18:41:12.413659Z] Running create-virtualenv step. 11:41:12 INFO - Running pre-action listener: _resource_record_pre_action 11:41:12 INFO - Running main action method: create_virtualenv 11:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:41:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:41:12 INFO - Using real prefix '/usr' 11:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:41:14 INFO - Installing pip.................done. 11:41:14 INFO - Return code: 0 11:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:41:15 INFO - Reading from file tmpfile_stdout 11:41:15 INFO - Output received: 11:41:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:41:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:41:15 INFO - Using env: {'DISPLAY': ':0', 11:41:15 INFO - 'HOME': '/home/cltbld', 11:41:15 INFO - 'LANG': 'en_US.UTF-8', 11:41:15 INFO - 'LANGUAGE': 'en_US:en', 11:41:15 INFO - 'LOGNAME': 'cltbld', 11:41:15 INFO - 'MAIL': '/var/mail/cltbld', 11:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:15 INFO - 'MOZ_NO_REMOTE': '1', 11:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:15 INFO - 'NO_EM_RESTART': '1', 11:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:15 INFO - 'PWD': '/builds/slave/test', 11:41:15 INFO - 'SHELL': '/bin/bash', 11:41:15 INFO - 'SHLVL': '1', 11:41:15 INFO - 'TERM': 'linux', 11:41:15 INFO - 'TMOUT': '86400', 11:41:15 INFO - 'USER': 'cltbld', 11:41:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:15 INFO - '_': '/tools/buildbot/bin/python'} 11:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:41:15 INFO - Cleaning up... 11:41:15 INFO - Return code: 0 11:41:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:41:15 INFO - Using env: {'DISPLAY': ':0', 11:41:15 INFO - 'HOME': '/home/cltbld', 11:41:15 INFO - 'LANG': 'en_US.UTF-8', 11:41:15 INFO - 'LANGUAGE': 'en_US:en', 11:41:15 INFO - 'LOGNAME': 'cltbld', 11:41:15 INFO - 'MAIL': '/var/mail/cltbld', 11:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:15 INFO - 'MOZ_NO_REMOTE': '1', 11:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:15 INFO - 'NO_EM_RESTART': '1', 11:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:15 INFO - 'PWD': '/builds/slave/test', 11:41:15 INFO - 'SHELL': '/bin/bash', 11:41:15 INFO - 'SHLVL': '1', 11:41:15 INFO - 'TERM': 'linux', 11:41:15 INFO - 'TMOUT': '86400', 11:41:15 INFO - 'USER': 'cltbld', 11:41:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:15 INFO - '_': '/tools/buildbot/bin/python'} 11:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:15 INFO - Downloading/unpacking psutil>=3.1.1 11:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:17 INFO - Installing collected packages: psutil 11:41:17 INFO - Running setup.py install for psutil 11:41:17 INFO - building 'psutil._psutil_linux' extension 11:41:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:41:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:41:18 INFO - building 'psutil._psutil_posix' extension 11:41:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:41:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:18 INFO - Successfully installed psutil 11:41:18 INFO - Cleaning up... 11:41:18 INFO - Return code: 0 11:41:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:18 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:41:18 INFO - Using env: {'DISPLAY': ':0', 11:41:18 INFO - 'HOME': '/home/cltbld', 11:41:18 INFO - 'LANG': 'en_US.UTF-8', 11:41:18 INFO - 'LANGUAGE': 'en_US:en', 11:41:18 INFO - 'LOGNAME': 'cltbld', 11:41:18 INFO - 'MAIL': '/var/mail/cltbld', 11:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:18 INFO - 'MOZ_NO_REMOTE': '1', 11:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:18 INFO - 'NO_EM_RESTART': '1', 11:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:18 INFO - 'PWD': '/builds/slave/test', 11:41:18 INFO - 'SHELL': '/bin/bash', 11:41:18 INFO - 'SHLVL': '1', 11:41:18 INFO - 'TERM': 'linux', 11:41:18 INFO - 'TMOUT': '86400', 11:41:18 INFO - 'USER': 'cltbld', 11:41:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:18 INFO - '_': '/tools/buildbot/bin/python'} 11:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:41:20 INFO - Installing collected packages: mozsystemmonitor 11:41:20 INFO - Running setup.py install for mozsystemmonitor 11:41:20 INFO - Successfully installed mozsystemmonitor 11:41:20 INFO - Cleaning up... 11:41:20 INFO - Return code: 0 11:41:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:20 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:41:20 INFO - Using env: {'DISPLAY': ':0', 11:41:20 INFO - 'HOME': '/home/cltbld', 11:41:20 INFO - 'LANG': 'en_US.UTF-8', 11:41:20 INFO - 'LANGUAGE': 'en_US:en', 11:41:20 INFO - 'LOGNAME': 'cltbld', 11:41:20 INFO - 'MAIL': '/var/mail/cltbld', 11:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:20 INFO - 'MOZ_NO_REMOTE': '1', 11:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:20 INFO - 'NO_EM_RESTART': '1', 11:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:20 INFO - 'PWD': '/builds/slave/test', 11:41:20 INFO - 'SHELL': '/bin/bash', 11:41:20 INFO - 'SHLVL': '1', 11:41:20 INFO - 'TERM': 'linux', 11:41:20 INFO - 'TMOUT': '86400', 11:41:20 INFO - 'USER': 'cltbld', 11:41:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:20 INFO - '_': '/tools/buildbot/bin/python'} 11:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:20 INFO - Downloading/unpacking jsonschema==2.5.1 11:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:41:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:41:23 INFO - warning: no files found matching '*.txt' 11:41:23 INFO - no previously-included directories found matching 'build' 11:41:23 INFO - no previously-included directories found matching 'dist' 11:41:23 INFO - no previously-included directories found matching '.git*' 11:41:23 INFO - Installing collected packages: jsonschema, functools32 11:41:23 INFO - Running setup.py install for functools32 11:41:23 INFO - warning: no files found matching '*.txt' 11:41:23 INFO - no previously-included directories found matching 'build' 11:41:23 INFO - no previously-included directories found matching 'dist' 11:41:23 INFO - no previously-included directories found matching '.git*' 11:41:23 INFO - Successfully installed jsonschema functools32 11:41:23 INFO - Cleaning up... 11:41:23 INFO - Return code: 0 11:41:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:23 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:41:23 INFO - Using env: {'DISPLAY': ':0', 11:41:23 INFO - 'HOME': '/home/cltbld', 11:41:23 INFO - 'LANG': 'en_US.UTF-8', 11:41:23 INFO - 'LANGUAGE': 'en_US:en', 11:41:23 INFO - 'LOGNAME': 'cltbld', 11:41:23 INFO - 'MAIL': '/var/mail/cltbld', 11:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:23 INFO - 'MOZ_NO_REMOTE': '1', 11:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:23 INFO - 'NO_EM_RESTART': '1', 11:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:23 INFO - 'PWD': '/builds/slave/test', 11:41:23 INFO - 'SHELL': '/bin/bash', 11:41:23 INFO - 'SHLVL': '1', 11:41:23 INFO - 'TERM': 'linux', 11:41:23 INFO - 'TMOUT': '86400', 11:41:23 INFO - 'USER': 'cltbld', 11:41:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:23 INFO - '_': '/tools/buildbot/bin/python'} 11:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:41:23 INFO - Cleaning up... 11:41:23 INFO - Return code: 0 11:41:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:23 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:41:23 INFO - Using env: {'DISPLAY': ':0', 11:41:23 INFO - 'HOME': '/home/cltbld', 11:41:23 INFO - 'LANG': 'en_US.UTF-8', 11:41:23 INFO - 'LANGUAGE': 'en_US:en', 11:41:23 INFO - 'LOGNAME': 'cltbld', 11:41:23 INFO - 'MAIL': '/var/mail/cltbld', 11:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:23 INFO - 'MOZ_NO_REMOTE': '1', 11:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:23 INFO - 'NO_EM_RESTART': '1', 11:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:23 INFO - 'PWD': '/builds/slave/test', 11:41:23 INFO - 'SHELL': '/bin/bash', 11:41:23 INFO - 'SHLVL': '1', 11:41:23 INFO - 'TERM': 'linux', 11:41:23 INFO - 'TMOUT': '86400', 11:41:23 INFO - 'USER': 'cltbld', 11:41:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:23 INFO - '_': '/tools/buildbot/bin/python'} 11:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:26 INFO - Downloading docopt-0.6.1.tar.gz 11:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:26 INFO - Running setup.py install for blobuploader 11:41:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:26 INFO - Running setup.py install for requests 11:41:27 INFO - Running setup.py install for docopt 11:41:27 INFO - Successfully installed blobuploader requests docopt 11:41:27 INFO - Cleaning up... 11:41:27 INFO - Return code: 0 11:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:27 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:27 INFO - Using env: {'DISPLAY': ':0', 11:41:27 INFO - 'HOME': '/home/cltbld', 11:41:27 INFO - 'LANG': 'en_US.UTF-8', 11:41:27 INFO - 'LANGUAGE': 'en_US:en', 11:41:27 INFO - 'LOGNAME': 'cltbld', 11:41:27 INFO - 'MAIL': '/var/mail/cltbld', 11:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:27 INFO - 'MOZ_NO_REMOTE': '1', 11:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:27 INFO - 'NO_EM_RESTART': '1', 11:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:27 INFO - 'PWD': '/builds/slave/test', 11:41:27 INFO - 'SHELL': '/bin/bash', 11:41:27 INFO - 'SHLVL': '1', 11:41:27 INFO - 'TERM': 'linux', 11:41:27 INFO - 'TMOUT': '86400', 11:41:27 INFO - 'USER': 'cltbld', 11:41:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:27 INFO - '_': '/tools/buildbot/bin/python'} 11:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:27 INFO - Running setup.py (path:/tmp/pip-OjHu_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:27 INFO - Running setup.py (path:/tmp/pip-dcSMWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:27 INFO - Running setup.py (path:/tmp/pip-1RdA22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:27 INFO - Running setup.py (path:/tmp/pip-y0Uu0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:27 INFO - Running setup.py (path:/tmp/pip-TwP6FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:27 INFO - Running setup.py (path:/tmp/pip-jibaNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:27 INFO - Running setup.py (path:/tmp/pip-7dsWgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:28 INFO - Running setup.py (path:/tmp/pip-RP_whg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:28 INFO - Running setup.py (path:/tmp/pip-TWTVrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:28 INFO - Running setup.py (path:/tmp/pip-as5VBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:28 INFO - Running setup.py (path:/tmp/pip-lvHcAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:28 INFO - Running setup.py (path:/tmp/pip-J0aQ98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:28 INFO - Running setup.py (path:/tmp/pip-9m4YxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:28 INFO - Running setup.py (path:/tmp/pip-LVR156-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:28 INFO - Running setup.py (path:/tmp/pip-0CFL0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:28 INFO - Running setup.py (path:/tmp/pip-7bY2YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:28 INFO - Running setup.py (path:/tmp/pip-Z6aTeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:28 INFO - Running setup.py install for manifestparser 11:41:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:28 INFO - Running setup.py install for mozcrash 11:41:28 INFO - Running setup.py install for mozdebug 11:41:29 INFO - Running setup.py install for mozdevice 11:41:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozfile 11:41:29 INFO - Running setup.py install for mozhttpd 11:41:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozinfo 11:41:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozInstall 11:41:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozleak 11:41:29 INFO - Running setup.py install for mozlog 11:41:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for moznetwork 11:41:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozprocess 11:41:30 INFO - Running setup.py install for mozprofile 11:41:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozrunner 11:41:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozscreenshot 11:41:30 INFO - Running setup.py install for moztest 11:41:30 INFO - Running setup.py install for mozversion 11:41:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:30 INFO - Cleaning up... 11:41:30 INFO - Return code: 0 11:41:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:30 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:30 INFO - Using env: {'DISPLAY': ':0', 11:41:30 INFO - 'HOME': '/home/cltbld', 11:41:30 INFO - 'LANG': 'en_US.UTF-8', 11:41:30 INFO - 'LANGUAGE': 'en_US:en', 11:41:30 INFO - 'LOGNAME': 'cltbld', 11:41:30 INFO - 'MAIL': '/var/mail/cltbld', 11:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:30 INFO - 'MOZ_NO_REMOTE': '1', 11:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:30 INFO - 'NO_EM_RESTART': '1', 11:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:30 INFO - 'PWD': '/builds/slave/test', 11:41:30 INFO - 'SHELL': '/bin/bash', 11:41:30 INFO - 'SHLVL': '1', 11:41:30 INFO - 'TERM': 'linux', 11:41:30 INFO - 'TMOUT': '86400', 11:41:30 INFO - 'USER': 'cltbld', 11:41:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:30 INFO - '_': '/tools/buildbot/bin/python'} 11:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:30 INFO - Running setup.py (path:/tmp/pip-4j2IpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:30 INFO - Running setup.py (path:/tmp/pip-WDA8aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:30 INFO - Running setup.py (path:/tmp/pip-zgugHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:31 INFO - Running setup.py (path:/tmp/pip-MWm4q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:31 INFO - Running setup.py (path:/tmp/pip-LTfnYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:31 INFO - Running setup.py (path:/tmp/pip-rgi1V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:31 INFO - Running setup.py (path:/tmp/pip-GBoj98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:31 INFO - Running setup.py (path:/tmp/pip-tI1vcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:31 INFO - Running setup.py (path:/tmp/pip-hKaukT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:31 INFO - Running setup.py (path:/tmp/pip-mJA0PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:31 INFO - Running setup.py (path:/tmp/pip-vr6KG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:31 INFO - Running setup.py (path:/tmp/pip-E3Rur2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:31 INFO - Running setup.py (path:/tmp/pip-cnxpBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:31 INFO - Running setup.py (path:/tmp/pip-KBhpM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:31 INFO - Running setup.py (path:/tmp/pip-fotq_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:31 INFO - Running setup.py (path:/tmp/pip-DNebEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:31 INFO - Running setup.py (path:/tmp/pip-2jk4BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41: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 11:41: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 11:41: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 11:41: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 11:41: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 11:41: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 11:41:34 INFO - Downloading blessings-1.6.tar.gz 11:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:34 INFO - Installing collected packages: blessings 11:41:34 INFO - Running setup.py install for blessings 11:41:34 INFO - Successfully installed blessings 11:41:34 INFO - Cleaning up... 11:41:34 INFO - Return code: 0 11:41:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:34 INFO - Reading from file tmpfile_stdout 11:41:34 INFO - Current package versions: 11:41:34 INFO - argparse == 1.2.1 11:41:34 INFO - blessings == 1.6 11:41:34 INFO - blobuploader == 1.2.4 11:41:34 INFO - docopt == 0.6.1 11:41:34 INFO - functools32 == 3.2.3-2 11:41:34 INFO - jsonschema == 2.5.1 11:41:34 INFO - manifestparser == 1.1 11:41:34 INFO - mozInstall == 1.12 11:41:34 INFO - mozcrash == 1.0 11:41:34 INFO - mozdebug == 0.1 11:41:34 INFO - mozdevice == 0.49 11:41:34 INFO - mozfile == 1.2 11:41:34 INFO - mozhttpd == 0.7 11:41:34 INFO - mozinfo == 0.9 11:41:34 INFO - mozleak == 0.1 11:41:34 INFO - mozlog == 3.4 11:41:34 INFO - moznetwork == 0.27 11:41:34 INFO - mozprocess == 0.25 11:41:34 INFO - mozprofile == 0.28 11:41:34 INFO - mozrunner == 6.13 11:41:34 INFO - mozscreenshot == 0.1 11:41:34 INFO - mozsystemmonitor == 0.3 11:41:34 INFO - moztest == 0.8 11:41:34 INFO - mozversion == 1.4 11:41:34 INFO - psutil == 3.1.1 11:41:34 INFO - requests == 1.2.3 11:41:34 INFO - wsgiref == 0.1.2 11:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41: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')]} 11:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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')]} 11:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:34 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 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:34 INFO - Using env: {'DISPLAY': ':0', 11:41:34 INFO - 'HOME': '/home/cltbld', 11:41:34 INFO - 'LANG': 'en_US.UTF-8', 11:41:34 INFO - 'LANGUAGE': 'en_US:en', 11:41:34 INFO - 'LOGNAME': 'cltbld', 11:41:34 INFO - 'MAIL': '/var/mail/cltbld', 11:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:34 INFO - 'MOZ_NO_REMOTE': '1', 11:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:34 INFO - 'NO_EM_RESTART': '1', 11:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:34 INFO - 'PWD': '/builds/slave/test', 11:41:34 INFO - 'SHELL': '/bin/bash', 11:41:34 INFO - 'SHLVL': '1', 11:41:34 INFO - 'TERM': 'linux', 11:41:34 INFO - 'TMOUT': '86400', 11:41:34 INFO - 'USER': 'cltbld', 11:41:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:34 INFO - '_': '/tools/buildbot/bin/python'} 11:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:34 INFO - Cleaning up... 11:41:34 INFO - Return code: 0 11:41:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41: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')]} 11:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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')]} 11:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17afb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, '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': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41: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'] in /builds/slave/test/build 11:41: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 11:41:34 INFO - Using env: {'DISPLAY': ':0', 11:41:34 INFO - 'HOME': '/home/cltbld', 11:41:34 INFO - 'LANG': 'en_US.UTF-8', 11:41:34 INFO - 'LANGUAGE': 'en_US:en', 11:41:34 INFO - 'LOGNAME': 'cltbld', 11:41:34 INFO - 'MAIL': '/var/mail/cltbld', 11:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:34 INFO - 'MOZ_NO_REMOTE': '1', 11:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:34 INFO - 'NO_EM_RESTART': '1', 11:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:34 INFO - 'PWD': '/builds/slave/test', 11:41:34 INFO - 'SHELL': '/bin/bash', 11:41:34 INFO - 'SHLVL': '1', 11:41:34 INFO - 'TERM': 'linux', 11:41:34 INFO - 'TMOUT': '86400', 11:41:34 INFO - 'USER': 'cltbld', 11:41:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:34 INFO - '_': '/tools/buildbot/bin/python'} 11:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:34 INFO - Cleaning up... 11:41:35 INFO - Return code: 0 11:41:35 INFO - Running post-action listener: _resource_record_post_action 11:41:35 INFO - Running post-action listener: _start_resource_monitoring 11:41:35 INFO - Starting resource monitoring. 11:41:35 INFO - [mozharness: 2017-03-30 18:41:35.031577Z] Finished create-virtualenv step (success) 11:41:35 INFO - [mozharness: 2017-03-30 18:41:35.032099Z] Running install step. 11:41:35 INFO - Running pre-action listener: _resource_record_pre_action 11:41:35 INFO - Running main action method: install 11:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:35 INFO - Reading from file tmpfile_stdout 11:41:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:35 INFO - Reading from file tmpfile_stdout 11:41:35 INFO - Output received: 11:41:35 INFO - Usage: mozinstall [options] installer 11:41:35 INFO - Options: 11:41:35 INFO - -h, --help show this help message and exit 11:41:35 INFO - -d DEST, --destination=DEST 11:41:35 INFO - Directory to install application into. [default: 11:41:35 INFO - "/builds/slave/test"] 11:41:35 INFO - --app=APP Application being installed. [default: firefox] 11:41:35 INFO - mkdir: /builds/slave/test/build/application 11:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:41:50 INFO - Reading from file tmpfile_stdout 11:41:50 INFO - Output received: 11:41:50 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:50 INFO - Running post-action listener: _resource_record_post_action 11:41:50 INFO - [mozharness: 2017-03-30 18:41:50.974197Z] Finished install step (success) 11:41:50 INFO - [mozharness: 2017-03-30 18:41:50.974534Z] Running run-tests step. 11:41:50 INFO - Running pre-action listener: _resource_record_pre_action 11:41:50 INFO - Running main action method: run_tests 11:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:50 INFO - Python 2.7.3 11:41:50 INFO - Return code: 0 11:41:50 INFO - grabbing minidump binary from tooltool 11:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:50 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 0x17ad290>, '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 0x17adb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ae040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:41:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:41:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:51 INFO - Return code: 0 11:41:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:51 INFO - ENV: RUST_BACKTRACE is now 1 11:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 11:41:51 INFO - Using env: {'DISPLAY': ':0', 11:41:51 INFO - 'HOME': '/home/cltbld', 11:41:51 INFO - 'LANG': 'en_US.UTF-8', 11:41:51 INFO - 'LANGUAGE': 'en_US:en', 11:41:51 INFO - 'LOGNAME': 'cltbld', 11:41:51 INFO - 'MAIL': '/var/mail/cltbld', 11:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:51 INFO - 'MOZ_NO_REMOTE': '1', 11:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:51 INFO - 'NO_EM_RESTART': '1', 11:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:51 INFO - 'PWD': '/builds/slave/test', 11:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:51 INFO - 'RUST_BACKTRACE': '1', 11:41:51 INFO - 'SHELL': '/bin/bash', 11:41:51 INFO - 'SHLVL': '1', 11:41:51 INFO - 'TERM': 'linux', 11:41:51 INFO - 'TMOUT': '86400', 11:41:51 INFO - 'USER': 'cltbld', 11:41:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296', 11:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:51 INFO - '_': '/tools/buildbot/bin/python'} 11:41:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:41:51 INFO - mozversion application_buildid: 20170330114804 11:41:51 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 11:41:51 INFO - mozversion application_display_name: Nightly 11:41:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:51 INFO - mozversion application_name: Firefox 11:41:51 INFO - mozversion application_remotingname: firefox 11:41:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:41:51 INFO - mozversion application_vendor: Mozilla 11:41:51 INFO - mozversion application_version: 55.0a1 11:41:51 INFO - mozversion platform_buildid: 20170330114804 11:41:51 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 11:41:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:41:51 INFO - mozversion platform_version: 55.0a1 11:41:51 INFO - using testdate: 1490899311 11:41:51 INFO - actual date: 1490899311 11:41:51 INFO - starting webserver on 'localhost:33385' 11:41:51 INFO - SUITE-START | Running 2 tests 11:41:51 INFO - TEST-START | dromaeo_css 11:41:51 INFO - operating with platform_type : linux_ 11:41:51 INFO - Initialising browser for dromaeo_css test... 11:41:51 INFO - TEST-INFO | started process 30847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFhue2/profile http://localhost:33385/getInfo.html) 11:41:55 INFO - PID 30847 | __metrics Screen width/height:1600/1200 11:41:55 INFO - PID 30847 | colorDepth:24 11:41:55 INFO - PID 30847 | Browser inner width/height: 1024/697 11:41:55 INFO - PID 30847 | __metrics 11:41:56 ERROR - PID 30847 | 1490899316758 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpSFhue2/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpSFhue2/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpSFhue2/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpSFhue2/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:41:56 ERROR - PID 30847 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:41:57 INFO - TEST-INFO | 30847: exit 0 11:41:57 INFO - Browser initialized. 11:41:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:57 INFO - TEST-INFO | started process 30979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFhue2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:09 INFO - PID 30979 | RSS: Main: 155848704 11:42:09 INFO - PID 30979 | 11:45:14 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33385/tests/dromaeo/cssquery-ext.html) 11:45:16 INFO - PID 30979 | RSS: Main: 166252544 11:45:16 INFO - PID 30979 | 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 30979 | 11:46:58 ERROR - PID 30979 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 30979 | Full stack: 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 30979 | 11:46:58 ERROR - PID 30979 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 30979 | Full stack: 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 30979 | 11:46:58 ERROR - PID 30979 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 30979 | Full stack: 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | ************************* 11:46:58 INFO - PID 30979 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 30979 | 11:46:58 ERROR - PID 30979 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 30979 | Full stack: 11:46:58 INFO - PID 30979 | ************************* 11:48:18 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-ext.html (next: http://localhost:33385/tests/dromaeo/cssquery-jquery.html) 11:48:19 INFO - PID 30979 | RSS: Main: 161251328 11:48:19 INFO - PID 30979 | 11:51:21 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33385/tests/dromaeo/cssquery-mootools.html) 11:51:21 INFO - PID 30979 | RSS: Main: 169242624 11:51:21 INFO - PID 30979 | 11:54:23 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33385/tests/dromaeo/cssquery-prototype.html) 11:54:24 INFO - PID 30979 | RSS: Main: 161554432 11:54:24 INFO - PID 30979 | 11:57:27 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33385/tests/dromaeo/cssquery-yui.html) 11:57:27 INFO - PID 30979 | RSS: Main: 168759296 11:57:27 INFO - PID 30979 | 12:00:30 INFO - PID 30979 | Cycle 1(1): loaded http://localhost:33385/tests/dromaeo/cssquery-yui.html (next: http://localhost:33385/tests/dromaeo/cssquery-dojo.html) 12:00:31 INFO - PID 30979 | RSS: Main: 162373632 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | __start_tp_report 12:00:31 INFO - PID 30979 | _x_x_mozilla_page_load 12:00:31 INFO - PID 30979 | _x_x_mozilla_page_load_details 12:00:31 INFO - PID 30979 | |i|pagename|runs| 12:00:31 INFO - PID 30979 | |0;dojo.html;2688.9193324200273;2726.754592086712;2735.0153944579947;2759.2274163234288;2763.820351677141;5230.79076836927;5297.761600727967;5316.468353164686;5357.196420536921;5365.892682146359;5259.158534634459;5282.154855223165;5298.523132918037;5377.193420986854;5391.865203369918;4811.25425559038;4830.73430961297;4852.975735121319;4861.222204447289;4863.416390033183;4808.639352048593;4835.5889749371345;4897.265410188483;4907;4974.751262436882;4743.31221972812;4766.928496072562;4799.1601469743;4833.9033219335415;4842.757862106881;4775.331453596499;4790.209615413452;4800.927986080212;4833.951660483421;4849.418069831608;4679.485256621769;4750.192467280571;4774.689645173053;4787.234042553175;4806.831760888352;5112.565431938289;5182.455842136559;5226.503482169188;5227.372715274153;5294.285271488338;5659.4340565943485;5693.202951586781;5734.856628584277;5738.254026976508;5750.626209296424;5676.659400435987;5698.572607054488;5705.258316418881;5707.429257074301;5715.1713001614535;5121.103806833789;5270.367555893317;5271.841844744664;5280.762365693553;5342.519173274424;5718.828435146952;5766.971165144231;5768.826935191951;5770.047942089592;5772.04761214395;5549.639273447213;5587.525060369833;5624.240727501735;5635.013872572284;5656.2929633795775;5624.887502250014;5689.601727879009;5707.6575405475805;5719.142128680731;5722.256106706185;5469.234307196995;5606.6916319602815;5626.437356264422;5646.265985421951;5651.971740141273;5547.140193269969;5636.943630563724;5690.943090569124;5719.456651618089;5723.59934804568;4773.618110551148;4792.161371759928;4795.064962332312;4802.471728109905;4833.492483289274;4063.045184381668;4084.9183016339507;4085.55058943516;4085.8978525536504;4110.280700877394;4760.238361862085;4779.95220047802;4828.203346447867;4885.780139893714;4891.9755401222765;5686.3744988051285;5726.513246374022;5731.111677689882;5741.913871291934;5786.450287222707;4849.418069831572;4855.1260773061185;4879.4388645305535;4886.60907127429;4903.01939612079;4902.411710594752;4961.032598643302;4962.181240095416;4979.551840334315;5080.847574572768;5207.505286997729;5250.133727934848;5257;5259.395169555397;5267.841964741064;5625.915611265752;5628.155776633538;5634.183043458594;5653.010723123519;5718.142278658234;5267.499587539178;5305.787768489217;5338.119210330407;5338.97330513345;5363.061464243664;5540.806071787468;5549.611527193058;5555;5557.277553917965;5581.246531718329;5569.805056822992;5643.435656434323;5677.886442271214;5690.430956904276;5766.509846663081;5443.183522471661;5469.3983661797965;5475.72621368922;5491.176323551499;5494.505494505353;5543.3902270751;5563.833085007456;5565.526930210977;5568.192612071308;5570.91643625354;5358.383785864676;5418.972905135607;5462.098753705594;5490.560755139659;5520.1167813149705;5510.035743744748;5516.062269414129;5559.11054231321;5577.637453565505;5594;5432.049391356576;5451.100568406168;5452.991196628636;5461;5466.316710411199 12:00:31 INFO - PID 30979 | |1;ext.html;627.5795217204472;668.7859884836853;682.249525521926;1187.5190547828126;1200.2738343302308;34768.82615586922;35562.64437355626;35770;35818;35917.461238081414;32967.1758206045;33236.16909577262;33259.83370083152;33516.16209594761;33557.496637550394;7363.226861179593;7539.4345424093135;7556.319931206191;7565.2812982766545;7573.356264717478;7516.924830751677;7571.6214189290595;7616.771496855075;7632.542047477142;7662.923370766304;7637.656305466267;7664.348530374925;7668.616569171519;7669.6165191740465;7701.152873183945;7553.584552849591;7604;7620.3141717245435;7622.618869056552;7650.158482566913;7425.034745483106;7472.065991751031;7504.962475187589;7519.736809211706;7526.661300241502;33943.660563394544;34259.31481370384;34454.44954977032;34465.483017754756;34467.482987755204;2546.987265063681;2590.4689538644534;2596.2470883443966;2625.173070482792;2627.8214753013654;23918.521629567484;23953.640695389582;23971.40071498209;24343.634845477332;24395.512089758282;2593.780922966203;2600.6489123968213;2606.491734111849;2633.855137967411;2646.8808903599192;130910;133699.33150334284;159351;159711;159962;39727;40249.59750402517;40298.79850600728;40390.79804600958;40409;42340;42464.78767606204;42470.78764606219;42540;42552.87235638206;12209;12365.38173091342;12372.07209459294;12382.318972456422;12392.442340094718;9715.659951901649;9731.610735570639;9750.75623109428;9792.853107203398;9796.853047204298;12935.805962910565;12952.417141228667;12986;13003.804942925864;13139.474421023053;5459.617826752089;5712.914306285409;5736.942630573641;5755.510781583528;5777.6822274775295;832.5712258187039;869.248100393168;870.9390342675952;885.0132102705437;895.3391458843881;18380.448586542425;19023.33418330352;19342.4197274082;19368.515787105436;19592.314269000515;972.6255391674115;974.7270764186039;981.66623348062;984.6110786239395;1000.1698590170287;10077.193824494023;10094.596216151273;10373.896261037293;10397.48012599367;10474.109700675528;240967;242718;242847;242866;243150;41580.58419415828;41713.58286417097;41853;41898.37152442716;41918.58081419147;1187.6615164678026;1228.6744012836605;1234.1422711215798;1235.5428491458217;1252.6242127361754;17857.910710446366;17940.434174436417;18673.545394102133;18850;19188.520286992938;29176.124716258546;29423.55864661989;29449.411011780074;29459.705402945696;29490.852545737132;242767;243763;244099;244408;244744;28546;29485.705142949155;30243.546346804374;30295.242618934702;30328.69671303347;35727;35730.46404303885;36926.26147476982;36968.44547331846;37004.074898127765;26891;27287.454250914474;27414.725852742016;27546;28731.712682872905;27424.314392140357;27616.723832761414;28007.944527683176;28224.435511289248;28484.287892802018;30089.398212035198;30243.848780755954;30388.39223215479;30502.847485762428;30862.228444289074;26948;27011.459770804868;27037;27179.72820271772;28134.85932570324;20553;21795.891020544797;21840;22299.66550501776;22377.216797412013 12:00:31 INFO - PID 30979 | |2;jquery.html;416.98749037528887;417.8119846069268;426.878339673193;433.9978300108499;438.30966228190607;17758.112094395277;18053.63892722148;18401.631967360663;18547.16537755801;18618.34835780748;16413.507594772145;16603.83396166038;16726.66546669069;17438.651226975486;17495;5588.552915766729;5642.576806739501;5712.542996560286;5761.9135712964335;5768.74040668171;5686;5759.136129580555;5774.2782152230975;5778.27771528559;5782.190493330937;5575.163725441196;5695.857603559903;5725.856853578653;5733.197352370671;5737.942620573783;5686.658800471964;5708.058170401879;5713.914291285634;5717.456841600062;5719.14212868069;4988.301637770715;5096.79612815487;5122.974385128051;5134.383873935114;5147.716875571842;21668.783312166834;22521.77478225213;22536.774632253633;22554.097836086537;22715.545689086124;1555.556661375325;1588.602849287678;1599.1045014791637;1611.798525184352;1624.8131464881571;13594.524191653245;14365;14482.782758258634;14721.92639036798;14898.851011489964;1645.1609679063645;1679.8908070975347;1713.3318005977678;1717.467585048639;1733.4539620019652;87622;88162;89690.10309896883;90349.54825225832;98726;19497.512562185777;19650.312239071565;19813.60372792536;20221.393358198984;20926.895365523076;33255;33301.3339733204;33421.498677519856;33512;33685.32629347399;8715.825683486295;8792.120787921285;8803.427777194462;8898.911010889939;9138.360314777901;7111.395531379787;7134.268537074107;7320.560766354036;7331.340179383881;7333.1200255969625;9196.218321442619;9601.615935362646;9804.852927206097;9814.852777208347;10096.869970309228;3655.1958569114754;3756.7370284079852;3854.0750219947013;3931.2137572485617;3953.802309884494;815.6939111082371;854.8845905802636;870.8214815962713;875.0811647769816;889.7330800759746;15329.693406131815;15572.68854622924;15802.209889505479;15848;16381.754273685905;868.2706526517629;869.5782545465444;870.8345414371249;880.6345366672759;901.2159421303508;8604.655813767378;8901.109889011048;8910.643574257087;9172.6789562365;9214.35499515041;447764;479677;486726;489500;497851;89384.5530772355;89387;91482;92718;93922.53038734762;1103.4868786014542;1113.1484414422973;1139.4245905817509;1142.5429828068673;1146.094585277638;16238.756418653966;16651.583710407336;16922.915385423486;17016.319347225974;17248.223829927934;40691.593084069966;40811.38782918318;41201.79399103105;41741;42166.36750448684;50343.74828125836;51807;52657.473425265256;53950;54017;7950.40371972116;8058.234467725557;8106.39202059836;8153.6330865112395;8191.508509489449;11945.343006134399;12003.63989080329;12140.392980351124;12396.442160102637;12515.311657858905;10701.090407315465;10785.406802625617;10940.781184376427;10994.505247263733;11106.944465277622;10339.844902326622;10656.680299591024;10809.783804324026;11001.339919604528;11041.171912106463;10632.681019569425;10695.465226738477;10753.569857205624;10963.835542467028;11280.49237784318;8071.556064416513;8091.8381632365845;8153.714619988272;8173.509589424653;8252.83494330122;10634.14926805869;10634.574617015542;10659.573617055232;10793.946030269799;11169.162312826407 12:00:31 INFO - PID 30979 | |3;mootools.html;1292.0890772005735;1340.209276526849;1362.3801170467439;1363.1820907455522;1368.6031050995211;9458;9679.467629280387;9841.015898410164;9853.408795472267;9989.450580218085;9632.084951929573;9814.50927453628;9817;9823.901760982388;9830.655927042555;2171.478845077182;2214.081156320125;2214.5792299463133;2217.079911836586;2219.2343641443676;2123.225022866658;2157.374361435182;2161.8919054047315;2199.087378737822;2209.5359974405396;2122.790009694475;2176.281826997087;2188.245055455865;2192.1012384922187;2204.305643722222;2138.1340557074254;2153.364757396572;2154.806067453921;2156.4393257753018;2157.244964262511;2082.187946700788;2118.2374345235703;2192.1669765489173;2200.658897870833;2200.7249093863265;9675.371100878421;9689.70930872075;9756.414615123116;9765.169960553361;9772.26707996896;5324.4675532446445;5471.343438787331;5489;5513.228148059235;5523.475269849358;3207.7433805295755;3387.6104248011547;3390.4744764561533;3390.830458477091;3471.89584312471;1011.3628414099144;1033.8035773203067;1054.114543783218;1057.6351158850184;1075.8547596074586;13963.65090872726;14076.085054471427;14108.929455352658;14166.645833854132;14221.786673199911;4696.530346965276;4784.114938736345;4955.108080545537;4958.528939750718;4972.453030166679;10330.121939635215;10370.688879333633;10372.11836993849;10398.064174224204;10467.110295624958;5280.498352656491;5376.032314183484;5378.220158077057;5378.704171270618;5385.542228910586;4741.004389078332;4846.442659094178;4875.609951203895;4992.675476094042;5015.448300686921;3738.476613274144;3898.2203559288255;3913.3542965410957;3971.212954170635;4013.8996525087105;1162.6802629276847;1165.7377090154648;1175.6179241746468;1199;1202.008343116932;687.0964681443985;689.9586024838526;698.4377576051328;704.2183176673888;711.4877288352378;5239.292695486137;5244.003639308519;5272.525472707474;5277.551408130275;5380.1929710542945;545.555372371516;559.7089513452981;564.2044716949082;564.3538148819579;573.8077743955738;3380.7295416366633;3491.633378495272;3522.5068490411363;3584.5160903277724;3603.6396360363756;12054.216475929037;12758.298293593942;12780.297083660302;12782.872171278354;12786.360681965865;12299.262044277371;12367.505299787908;12624.495020199272;12627.368631568384;12661.303628300531;9131.817363652823;9147.679831205876;9256.95371523138;9299.34904556688;9326.207272381787;5305.439164759845;5320.388155362183;5372.355317361941;5442.102053161184;5536.114221724505;11167.867190773628;11317.490712918103;11376.374299413612;11400.48697808584;11421.828672570084;11585.6524304271;11601.071914247008;11712.590059347882;11733.237339572901;11742.471588778355;7344.632768361667;7459.067616547932;7471.663775130023;7471.6637751302405;7917.089534703583;9297.488638124969;9302.395344302598;9368.578413971523;9394.530273486434;9425.481598512148;7313.817154570966;7419.888701669587;7494.925050749423;7541.585212813128;7639.236076392539;7412;7451.143118541437;7510.361619262424;7528.811779705551;7762.3790096793255;6643.900341494978;6657.367550082734;6687.164104486939;6766.7969960901255;6771.762988295386;4764;4945.826896058621;5001.799928002839;5015.724135172454;5052.797888084436;4839.7096174229655;4902.264660300983;4947.208446648663;4999.800007999639;5029.798808047637 12:00:31 INFO - PID 30979 | |4;prototype.html;377.3735598905817;384.3964974989267;390.80069164726;394.07392627325805;397.20360676842927;5460.088968860897;5651.3218413790355;5679.460451257134;5718.77124915004;5734.512566431853;5413.458654134584;5506.752196151173;5510.531604813586;5512.779488820443;5525.171224316355;4275.850345237917;4277.230098582262;4280.464941882265;4286.549912259199;4303.085127118434;4196.370544418346;4209.452771139763;4223.303154979425;4293.184294983958;4307.181635489263;4184.581541845806;4204.1801848639525;4215.52456640175;4217.325227963526;4221.620054195122;4209.810558524874;4223.260929337369;4226.260404429213;4228.703990720651;4260.70175087744;3711.7030637548933;3727.2545490901657;3732.720045996561;3733.2533493301175;3736.3648179809497;5241.318628578299;5313.57491400687;5342.435630897191;5371.516563509303;5403.594730395197;4832.782524786393;4843.782029808667;4849.781759820817;4864.513548645143;4887.120318342697;5582.106862901916;5777.277840269966;5788.913166302509;5796.652200867961;5804.62269952456;4016.7589944603124;4045.696572757055;4056.310427227349;4070.1859628074208;4071.389291606253;5976.581639285252;6120.877582448326;6158.507319414436;6173.876522469525;6188.721507532126;4099.795010249476;4123.134141830249;4124.628783409507;4141.171765646823;4141.378793180987;4181.226473102486;4183.3515805050265;4190.497140343178;4190.51809041964;4191.97904010478;4753;4789;4807.206810876166;4827.927581086286;4841.903161936812;5773;5786.971065144648;5800.303963524404;5805.187273781674;5808.361080281165;1443.2711480702178;1449.173970836613;1450.0936914428482;1451.75320195567;1452.2738630684657;934.3100517846349;983.7343917142332;987.8096893243625;994.6121012805012;996.1681995533811;5065.240213967934;5065.974670126626;5068.302118790173;5069.543741063322;5098.745062746848;5992.161097446361;6094.3545242785085;6104.847378815476;6108.205933228652;6122.448979591858;4908.680935739237;5044.1677123274985;5073.543381095719;5099.23511473282;5111.616628752859;3193.888213912502;3223.065311059813;3232.3050544133125;3234.692704193098;3252.577164968539;5494.203340515603;5629.943700563023;5632.662040277596;5639.577031722637;5668.291463567054;6071.150038994544;6096.664683442454;6155;6158.538109641795;6173.969130154321;5574.275344205227;5595.468430499096;5628.802991895264;5630.662160270315;5642.520385767091;5841.532677385884;5995.520358371233;6022.36278065878;6032;6040.728167232397;5948.37542058095;5963.52291816645;5964.165016897725;5969.641821490724;5977.462028417463;5342.78628854857;5419.160030195326;5467.617266791286;5550.139728342114;5617.887642247214;4122.237386083464;4132.276851551027;4136.110736191733;4146.896327591834;4149.6472799811145;5805.506531944832;6016.819495415145;6040.939590604214;6058.182145410313;6071.483923866344;5782.971085144547;5829.271341082364;5830.1140935235635;5868.2664666916635;5869.530437564899;5816.487713194684;5839.211706419749;5844.298684157929;5853.887761325334;5859.824205273849;5640.492355687844;5730.398308177581;5758.165066065313;5760.395158508464;5761.56788240892;5887.116932460165;5894.322152952293;5900.173975643327;5901.852453688693;5921.2006379138265;5595.6985378626805;5713.400092990342;5718.1708652246025;5736.225609542658;5743.396943320891 12:00:31 INFO - PID 30979 | |5;yui.html;604;605.3885575568677;614.9300217621338;624.8750249950006;636.3318515558665;13331.466741330347;13544.59366219015;13805.51680691176;13991.790123148148;13992.230427326505;13777;13821.861781382184;13858.514951976684;13872.653183670389;13966.231857247847;653.3694984340111;660.2638058564689;906.8322360363321;909.854423292275;936.9718908432724;937.6858752317981;941.9246460283196;944.1455482788053;946.6828612414849;948.4451595816456;988.1107003696694;988.3921388346188;988.6836212412031;993.2401712689798;995.5967833027636;970.5972021611022;971.5822196455522;971.7133445633519;973.1873885305778;981.4552923127661;720.4488566246825;725.5139056831882;727.2073439950426;729.9890501642479;730.3426915775791;13062.34688265583;13286.3356832158;14132.152070875678;14325.856741432557;14469.493567725185;11448.255863368937;13137.211767293993;13361.997850161277;13409.46362145513;13497.865021349759;9010.639574417015;9061.773455663595;9134.406263592911;9152.359334846564;9472.387518502692;2319.686842276288;2339.087755775249;2396.700412448444;2410.843295185807;2411.5297516984197;59993.400065999216;61010.694946524985;61304;61508.077378839356;62268.68865655688;9131.178193962574;9265.397749146285;9271.258299336037;9325.393849399903;9713.757156071013;20133.295334663217;20150;20166.19335226604;20170;20261.189552417738;5712.65724056558;5723.084306510938;5747;5873.4126587340925;5956.047032474783;2912.88348466059;2915.1691767846487;2919.5038242302526;2931.311141881656;2956.3496030873175;3252.593425821772;3283.622383425889;3324.1523411529906;3352.379809735207;3373.241020770356;592.925884264467;594.5956749410442;608.0605464557269;609.960352577081;617.1853153836981;410.8274524699633;412.36495796473696;423.5531514252432;432.5695932547136;444.73316010394154;7064.92935070653;7336.7798966031105;7601.619919004138;7615.314621684075;7650.540967541965;449.29685042907744;459.3890126132236;459.59325996493345;468.26482422596195;481.7904211667936;3242.1084201844683;3275.1157187559224;3357.093584732109;3371.8314084296176;3515.6132825389186;59511;59611;60433.39566604366;60994.69502652458;61516.38483615196;52589.7370513145;53048.73475632597;53684.19473707898;53968.460315397126;54884.451155488736;49899.25151122736;49994.75023623946;50323.496765032614;50645.746771265905;51029.74485127625;6658.1344425224415;6821.727130914906;6843.213030501556;6861.622610756456;6967;23952.88023559871;24287.51424971526;24893.87553062223;25692.229233123035;27247.45505089927;40369;41020.1795964085;41446.79276603598;42145.578544214164;44201.33697994468;10841.783164336512;11100.111991040536;11146.164037697366;11187.664370068911;11377.829332559853;11053.392063436588;11234.708008579119;11524.539018439169;11707.707307317385;12137.332446715161;10241.897581024392;10577.259591828499;10626.149908007186;11075.113990880549;11239.157063220127;11074.39090850011;11219.04270519134;11247.156463265452;11306.886931130583;11746.236494627821;9761.951190244003;9876.35803672759;9983.750406239902;10429.061384475433;10436.791264174522;7979.5611241382285;8059.637316320897;8311.501309921425;8379.748607541784;8391.664333426594;8960.283177345666;9166.404183728037;9189.540522973959;9290.16388525036;9329.933038044413 12:00:31 INFO - PID 30979 | __end_tp_report 12:00:31 INFO - PID 30979 | __start_cc_report 12:00:31 INFO - PID 30979 | _x_x_mozilla_cycle_collect,383 12:00:31 INFO - PID 30979 | __end_cc_report 12:00:31 INFO - PID 30979 | __startTimestamp1490900431008__endTimestamp 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | ------- Summary: start ------- 12:00:31 INFO - PID 30979 | Number of tests: 6 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#0] dojo.html Cycles:165 Average:5209.55 Median:5363.06 stddev:592.58 (11.0%) stddev-sans-first:560.44 12:00:31 INFO - PID 30979 | Values: 2688.9 2726.8 2735.0 2759.2 2763.8 5230.8 5297.8 5316.5 5357.2 5365.9 5259.2 5282.2 5298.5 5377.2 5391.9 4811.3 4830.7 4853.0 4861.2 4863.4 4808.6 4835.6 4897.3 4907.0 4974.8 4743.3 4766.9 4799.2 4833.9 4842.8 4775.3 4790.2 4800.9 4834.0 4849.4 4679.5 4750.2 4774.7 4787.2 4806.8 5112.6 5182.5 5226.5 5227.4 5294.3 5659.4 5693.2 5734.9 5738.3 5750.6 5676.7 5698.6 5705.3 5707.4 5715.2 5121.1 5270.4 5271.8 5280.8 5342.5 5718.8 5767.0 5768.8 5770.0 5772.0 5549.6 5587.5 5624.2 5635.0 5656.3 5624.9 5689.6 5707.7 5719.1 5722.3 5469.2 5606.7 5626.4 5646.3 5652.0 5547.1 5636.9 5690.9 5719.5 5723.6 4773.6 4792.2 4795.1 4802.5 4833.5 4063.0 4084.9 4085.6 4085.9 4110.3 4760.2 4780.0 4828.2 4885.8 4892.0 5686.4 5726.5 5731.1 5741.9 5786.5 4849.4 4855.1 4879.4 4886.6 4903.0 4902.4 4961.0 4962.2 4979.6 5080.8 5207.5 5250.1 5257.0 5259.4 5267.8 5625.9 5628.2 5634.2 5653.0 5718.1 5267.5 5305.8 5338.1 5339.0 5363.1 5540.8 5549.6 5555.0 5557.3 5581.2 5569.8 5643.4 5677.9 5690.4 5766.5 5443.2 5469.4 5475.7 5491.2 5494.5 5543.4 5563.8 5565.5 5568.2 5570.9 5358.4 5419.0 5462.1 5490.6 5520.1 5510.0 5516.1 5559.1 5577.6 5594.0 5432.0 5451.1 5453.0 5461.0 5466.3 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#1] ext.html Cycles:180 Average:34816.37 Median:30166.47 stddev:56585.03 (187.6%) stddev-sans-first:56685.53 12:00:31 INFO - PID 30979 | Values: 627.6 668.8 682.2 1187.5 1200.3 34768.8 35562.6 35770.0 35818.0 35917.5 32967.2 33236.2 33259.8 33516.2 33557.5 7363.2 7539.4 7556.3 7565.3 7573.4 7516.9 7571.6 7616.8 7632.5 7662.9 7637.7 7664.3 7668.6 7669.6 7701.2 7553.6 7604.0 7620.3 7622.6 7650.2 7425.0 7472.1 7505.0 7519.7 7526.7 33943.7 34259.3 34454.4 34465.5 34467.5 2547.0 2590.5 2596.2 2625.2 2627.8 23918.5 23953.6 23971.4 24343.6 24395.5 2593.8 2600.6 2606.5 2633.9 2646.9 130910.0 133699.3 159351.0 159711.0 159962.0 39727.0 40249.6 40298.8 40390.8 40409.0 42340.0 42464.8 42470.8 42540.0 42552.9 12209.0 12365.4 12372.1 12382.3 12392.4 9715.7 9731.6 9750.8 9792.9 9796.9 12935.8 12952.4 12986.0 13003.8 13139.5 5459.6 5712.9 5736.9 5755.5 5777.7 832.6 869.2 870.9 885.0 895.3 18380.4 19023.3 19342.4 19368.5 19592.3 972.6 974.7 981.7 984.6 1000.2 10077.2 10094.6 10373.9 10397.5 10474.1 240967.0 242718.0 242847.0 242866.0 243150.0 41580.6 41713.6 41853.0 41898.4 41918.6 1187.7 1228.7 1234.1 1235.5 1252.6 17857.9 17940.4 18673.5 18850.0 19188.5 29176.1 29423.6 29449.4 29459.7 29490.9 242767.0 243763.0 244099.0 244408.0 244744.0 28546.0 29485.7 30243.5 30295.2 30328.7 35727.0 35730.5 36926.3 36968.4 37004.1 26891.0 27287.5 27414.7 27546.0 28731.7 27424.3 27616.7 28007.9 28224.4 28484.3 30089.4 30243.8 30388.4 30502.8 30862.2 26948.0 27011.5 27037.0 27179.7 28134.9 20553.0 21795.9 21840.0 22299.7 22377.2 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#2] jquery.html Cycles:180 Average:29429.52 Median:21079.41 stddev:79371.56 (376.5%) stddev-sans-first:79564.33 12:00:31 INFO - PID 30979 | Values: 417.0 417.8 426.9 434.0 438.3 17758.1 18053.6 18401.6 18547.2 18618.3 16413.5 16603.8 16726.7 17438.7 17495.0 5588.6 5642.6 5712.5 5761.9 5768.7 5686.0 5759.1 5774.3 5778.3 5782.2 5575.2 5695.9 5725.9 5733.2 5737.9 5686.7 5708.1 5713.9 5717.5 5719.1 4988.3 5096.8 5123.0 5134.4 5147.7 21668.8 22521.8 22536.8 22554.1 22715.5 1555.6 1588.6 1599.1 1611.8 1624.8 13594.5 14365.0 14482.8 14721.9 14898.9 1645.2 1679.9 1713.3 1717.5 1733.5 87622.0 88162.0 89690.1 90349.5 98726.0 19497.5 19650.3 19813.6 20221.4 20926.9 33255.0 33301.3 33421.5 33512.0 33685.3 8715.8 8792.1 8803.4 8898.9 9138.4 7111.4 7134.3 7320.6 7331.3 7333.1 9196.2 9601.6 9804.9 9814.9 10096.9 3655.2 3756.7 3854.1 3931.2 3953.8 815.7 854.9 870.8 875.1 889.7 15329.7 15572.7 15802.2 15848.0 16381.8 868.3 869.6 870.8 880.6 901.2 8604.7 8901.1 8910.6 9172.7 9214.4 447764.0 479677.0 486726.0 489500.0 497851.0 89384.6 89387.0 91482.0 92718.0 93922.5 1103.5 1113.1 1139.4 1142.5 1146.1 16238.8 16651.6 16922.9 17016.3 17248.2 40691.6 40811.4 41201.8 41741.0 42166.4 50343.7 51807.0 52657.5 53950.0 54017.0 7950.4 8058.2 8106.4 8153.6 8191.5 11945.3 12003.6 12140.4 12396.4 12515.3 10701.1 10785.4 10940.8 10994.5 11106.9 10339.8 10656.7 10809.8 11001.3 11041.2 10632.7 10695.5 10753.6 10963.8 11280.5 8071.6 8091.8 8153.7 8173.5 8252.8 10634.1 10634.6 10659.6 10793.9 11169.2 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#3] mootools.html Cycles:180 Average:6039.96 Median:4861.03 stddev:3840.39 (79.0%) stddev-sans-first:3834.59 12:00:31 INFO - PID 30979 | Values: 1292.1 1340.2 1362.4 1363.2 1368.6 9458.0 9679.5 9841.0 9853.4 9989.5 9632.1 9814.5 9817.0 9823.9 9830.7 2171.5 2214.1 2214.6 2217.1 2219.2 2123.2 2157.4 2161.9 2199.1 2209.5 2122.8 2176.3 2188.2 2192.1 2204.3 2138.1 2153.4 2154.8 2156.4 2157.2 2082.2 2118.2 2192.2 2200.7 2200.7 9675.4 9689.7 9756.4 9765.2 9772.3 5324.5 5471.3 5489.0 5513.2 5523.5 3207.7 3387.6 3390.5 3390.8 3471.9 1011.4 1033.8 1054.1 1057.6 1075.9 13963.7 14076.1 14108.9 14166.6 14221.8 4696.5 4784.1 4955.1 4958.5 4972.5 10330.1 10370.7 10372.1 10398.1 10467.1 5280.5 5376.0 5378.2 5378.7 5385.5 4741.0 4846.4 4875.6 4992.7 5015.4 3738.5 3898.2 3913.4 3971.2 4013.9 1162.7 1165.7 1175.6 1199.0 1202.0 687.1 690.0 698.4 704.2 711.5 5239.3 5244.0 5272.5 5277.6 5380.2 545.6 559.7 564.2 564.4 573.8 3380.7 3491.6 3522.5 3584.5 3603.6 12054.2 12758.3 12780.3 12782.9 12786.4 12299.3 12367.5 12624.5 12627.4 12661.3 9131.8 9147.7 9257.0 9299.3 9326.2 5305.4 5320.4 5372.4 5442.1 5536.1 11167.9 11317.5 11376.4 11400.5 11421.8 11585.7 11601.1 11712.6 11733.2 11742.5 7344.6 7459.1 7471.7 7471.7 7917.1 9297.5 9302.4 9368.6 9394.5 9425.5 7313.8 7419.9 7494.9 7541.6 7639.2 7412.0 7451.1 7510.4 7528.8 7762.4 6643.9 6657.4 6687.2 6766.8 6771.8 4764.0 4945.8 5001.8 5015.7 5052.8 4839.7 4902.3 4947.2 4999.8 5029.8 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#4] prototype.html Cycles:180 Average:4807.06 Median:5500.48 stddev:1416.05 (25.7%) stddev-sans-first:1380.44 12:00:31 INFO - PID 30979 | Values: 377.4 384.4 390.8 394.1 397.2 5460.1 5651.3 5679.5 5718.8 5734.5 5413.5 5506.8 5510.5 5512.8 5525.2 4275.9 4277.2 4280.5 4286.5 4303.1 4196.4 4209.5 4223.3 4293.2 4307.2 4184.6 4204.2 4215.5 4217.3 4221.6 4209.8 4223.3 4226.3 4228.7 4260.7 3711.7 3727.3 3732.7 3733.3 3736.4 5241.3 5313.6 5342.4 5371.5 5403.6 4832.8 4843.8 4849.8 4864.5 4887.1 5582.1 5777.3 5788.9 5796.7 5804.6 4016.8 4045.7 4056.3 4070.2 4071.4 5976.6 6120.9 6158.5 6173.9 6188.7 4099.8 4123.1 4124.6 4141.2 4141.4 4181.2 4183.4 4190.5 4190.5 4192.0 4753.0 4789.0 4807.2 4827.9 4841.9 5773.0 5787.0 5800.3 5805.2 5808.4 1443.3 1449.2 1450.1 1451.8 1452.3 934.3 983.7 987.8 994.6 996.2 5065.2 5066.0 5068.3 5069.5 5098.7 5992.2 6094.4 6104.8 6108.2 6122.4 4908.7 5044.2 5073.5 5099.2 5111.6 3193.9 3223.1 3232.3 3234.7 3252.6 5494.2 5629.9 5632.7 5639.6 5668.3 6071.2 6096.7 6155.0 6158.5 6174.0 5574.3 5595.5 5628.8 5630.7 5642.5 5841.5 5995.5 6022.4 6032.0 6040.7 5948.4 5963.5 5964.2 5969.6 5977.5 5342.8 5419.2 5467.6 5550.1 5617.9 4122.2 4132.3 4136.1 4146.9 4149.6 5805.5 6016.8 6040.9 6058.2 6071.5 5783.0 5829.3 5830.1 5868.3 5869.5 5816.5 5839.2 5844.3 5853.9 5859.8 5640.5 5730.4 5758.2 5760.4 5761.6 5887.1 5894.3 5900.2 5901.9 5921.2 5595.7 5713.4 5718.2 5736.2 5743.4 12:00:31 INFO - PID 30979 | 12:00:31 INFO - PID 30979 | [#5] yui.html Cycles:180 Average:13796.04 Median:50837.75 stddev:17210.68 (33.9%) stddev-sans-first:17230.45 12:00:31 INFO - PID 30979 | Values: 604.0 605.4 614.9 624.9 636.3 13331.5 13544.6 13805.5 13991.8 13992.2 13777.0 13821.9 13858.5 13872.7 13966.2 653.4 660.3 906.8 909.9 937.0 937.7 941.9 944.1 946.7 948.4 988.1 988.4 988.7 993.2 995.6 970.6 971.6 971.7 973.2 981.5 720.4 725.5 727.2 730.0 730.3 13062.3 13286.3 14132.2 14325.9 14469.5 11448.3 13137.2 13362.0 13409.5 13497.9 9010.6 9061.8 9134.4 9152.4 9472.4 2319.7 2339.1 2396.7 2410.8 2411.5 59993.4 61010.7 61304.0 61508.1 62268.7 9131.2 9265.4 9271.3 9325.4 9713.8 20133.3 20150.0 20166.2 20170.0 20261.2 5712.7 5723.1 5747.0 5873.4 5956.0 2912.9 2915.2 2919.5 2931.3 2956.3 3252.6 3283.6 3324.2 3352.4 3373.2 592.9 594.6 608.1 610.0 617.2 410.8 412.4 423.6 432.6 444.7 7064.9 7336.8 7601.6 7615.3 7650.5 449.3 459.4 459.6 468.3 481.8 3242.1 3275.1 3357.1 3371.8 3515.6 59511.0 59611.0 60433.4 60994.7 61516.4 52589.7 53048.7 53684.2 53968.5 54884.5 49899.3 49994.8 50323.5 50645.7 51029.7 6658.1 6821.7 6843.2 6861.6 6967.0 23952.9 24287.5 24893.9 25692.2 27247.5 40369.0 41020.2 41446.8 42145.6 44201.3 10841.8 11100.1 11146.2 11187.7 11377.8 11053.4 11234.7 11524.5 11707.7 12137.3 10241.9 10577.3 10626.1 11075.1 11239.2 11074.4 11219.0 11247.2 11306.9 11746.2 9762.0 9876.4 9983.8 10429.1 10436.8 7979.6 8059.6 8311.5 8379.7 8391.7 8960.3 9166.4 9189.5 9290.2 9329.9 12:00:31 INFO - PID 30979 | -------- Summary: end -------- 12:00:31 INFO - PID 30979 | 12:00:31 INFO - TEST-INFO | 30979: exit 0 12:00:31 INFO - TEST-OK | dromaeo_css | took 1120613ms 12:00:31 INFO - TEST-START | kraken 12:00:31 INFO - operating with platform_type : linux_ 12:00:31 INFO - Initialising browser for kraken test... 12:00:31 INFO - TEST-INFO | started process 31361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTQIBZo/profile http://localhost:33385/getInfo.html) 12:00:36 INFO - PID 31361 | __metrics Screen width/height:1600/1200 12:00:36 INFO - PID 31361 | colorDepth:24 12:00:36 INFO - PID 31361 | Browser inner width/height: 1024/697 12:00:36 INFO - PID 31361 | __metrics 12:00:37 ERROR - PID 31361 | 1490900437144 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpTQIBZo/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpTQIBZo/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpTQIBZo/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpTQIBZo/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:00:37 ERROR - PID 31361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 12:00:38 INFO - TEST-INFO | 31361: exit 0 12:00:38 INFO - Browser initialized. 12:00:38 INFO - Running cycle 1/1 for kraken test... 12:00:38 INFO - TEST-INFO | started process 31494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTQIBZo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:50 INFO - PID 31494 | RSS: Main: 155770880 12:00:50 INFO - PID 31494 | 12:00:53 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33385/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:54 INFO - PID 31494 | RSS: Main: 162705408 12:00:54 INFO - PID 31494 | 12:00:56 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33385/tests/kraken/driver.html?testName=audio-dft) 12:00:57 INFO - PID 31494 | RSS: Main: 161267712 12:00:57 INFO - PID 31494 | 12:01:00 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33385/tests/kraken/driver.html?testName=audio-fft) 12:01:01 INFO - PID 31494 | RSS: Main: 157786112 12:01:01 INFO - PID 31494 | 12:01:03 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33385/tests/kraken/driver.html?testName=audio-oscillator) 12:01:03 INFO - PID 31494 | RSS: Main: 158683136 12:01:03 INFO - PID 31494 | 12:01:05 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:01:06 INFO - PID 31494 | RSS: Main: 158777344 12:01:06 INFO - PID 31494 | 12:01:09 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33385/tests/kraken/driver.html?testName=imaging-darkroom) 12:01:10 INFO - PID 31494 | RSS: Main: 164319232 12:01:10 INFO - PID 31494 | 12:01:14 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33385/tests/kraken/driver.html?testName=imaging-desaturate) 12:01:14 INFO - PID 31494 | RSS: Main: 161423360 12:01:14 INFO - PID 31494 | 12:01:17 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33385/tests/kraken/driver.html?testName=json-parse-financial) 12:01:18 INFO - PID 31494 | RSS: Main: 162930688 12:01:18 INFO - PID 31494 | 12:01:20 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:01:20 INFO - PID 31494 | RSS: Main: 163205120 12:01:20 INFO - PID 31494 | 12:01:22 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:01:23 INFO - PID 31494 | RSS: Main: 163278848 12:01:23 INFO - PID 31494 | 12:01:25 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:01:26 INFO - PID 31494 | RSS: Main: 164081664 12:01:26 INFO - PID 31494 | 12:01:28 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:01:29 INFO - PID 31494 | RSS: Main: 164261888 12:01:29 INFO - PID 31494 | 12:01:32 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:33 INFO - PID 31494 | RSS: Main: 163860480 12:01:33 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | Cycle 1(1): loaded http://localhost:33385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33385/tests/kraken/driver.html?testName=ai-astar) 12:01:35 INFO - PID 31494 | RSS: Main: 165429248 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | __start_tp_report 12:01:35 INFO - PID 31494 | _x_x_mozilla_page_load 12:01:35 INFO - PID 31494 | _x_x_mozilla_page_load_details 12:01:35 INFO - PID 31494 | |i|pagename|runs| 12:01:35 INFO - PID 31494 | |0;ai-astar;111;115;112;112;112;111;112;112;112;112 12:01:35 INFO - PID 31494 | |1;audio-beat-detection;152;125;126;174;127;127;125;131;145;127 12:01:35 INFO - PID 31494 | |2;audio-dft;165;168;167;173;168;170;175;167;168;164 12:01:35 INFO - PID 31494 | |3;audio-fft;76;76;75;107;78;76;76;76;98;75 12:01:35 INFO - PID 31494 | |4;audio-oscillator;85;84;107;85;85;85;97;85;86;110 12:01:35 INFO - PID 31494 | |5;imaging-gaussian-blur;114;114;114;114;114;120;115;114;117;115 12:01:35 INFO - PID 31494 | |6;imaging-darkroom;151;151;153;150;151;151;152;152;152;150 12:01:35 INFO - PID 31494 | |7;imaging-desaturate;95;96;97;95;97;95;95;96;96;95 12:01:35 INFO - PID 31494 | |8;json-parse-financial;67;68;67;67;69;68;68;70;68;68 12:01:35 INFO - PID 31494 | |9;json-stringify-tinderbox;57;56;56;55;56;56;56;57;56;56 12:01:35 INFO - PID 31494 | |10;stanford-crypto-aes;94;83;84;86;96;87;85;86;83;84 12:01:35 INFO - PID 31494 | |11;stanford-crypto-ccm;145;138;135;139;142;135;144;142;196;134 12:01:35 INFO - PID 31494 | |12;stanford-crypto-pbkdf2;193;194;194;198;189;196;193;194;195;197 12:01:35 INFO - PID 31494 | |13;stanford-crypto-sha256-iterative;72;73;74;72;71;74;70;73;70;77 12:01:35 INFO - PID 31494 | __end_tp_report 12:01:35 INFO - PID 31494 | __start_cc_report 12:01:35 INFO - PID 31494 | _x_x_mozilla_cycle_collect,883 12:01:35 INFO - PID 31494 | __end_cc_report 12:01:35 INFO - PID 31494 | __startTimestamp1490900495646__endTimestamp 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | ------- Summary: start ------- 12:01:35 INFO - PID 31494 | Number of tests: 14 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 12:01:35 INFO - PID 31494 | Values: 111.0 115.0 112.0 112.0 112.0 111.0 112.0 112.0 112.0 112.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:129.00 stddev:16.30 (12.6%) stddev-sans-first:16.21 12:01:35 INFO - PID 31494 | Values: 152.0 125.0 126.0 174.0 127.0 127.0 125.0 131.0 145.0 127.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#2] audio-dft Cycles:10 Average:168.50 Median:168.00 stddev:3.37 (2.0%) stddev-sans-first:3.33 12:01:35 INFO - PID 31494 | Values: 165.0 168.0 167.0 173.0 168.0 170.0 175.0 167.0 168.0 164.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.40 (15.0%) stddev-sans-first:11.93 12:01:35 INFO - PID 31494 | Values: 76.0 76.0 75.0 107.0 78.0 76.0 76.0 76.0 98.0 75.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:85.00 stddev:10.04 (11.8%) stddev-sans-first:10.42 12:01:35 INFO - PID 31494 | Values: 85.0 84.0 107.0 85.0 85.0 85.0 97.0 85.0 86.0 110.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.50 stddev:1.97 (1.7%) stddev-sans-first:2.05 12:01:35 INFO - PID 31494 | Values: 114.0 114.0 114.0 114.0 114.0 120.0 115.0 114.0 117.0 115.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 12:01:35 INFO - PID 31494 | Values: 151.0 151.0 153.0 150.0 151.0 151.0 152.0 152.0 152.0 150.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 12:01:35 INFO - PID 31494 | Values: 95.0 96.0 97.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 12:01:35 INFO - PID 31494 | Values: 67.0 68.0 67.0 67.0 69.0 68.0 68.0 70.0 68.0 68.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 12:01:35 INFO - PID 31494 | Values: 57.0 56.0 56.0 55.0 56.0 56.0 56.0 57.0 56.0 56.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:4.54 (5.3%) stddev-sans-first:4.00 12:01:35 INFO - PID 31494 | Values: 94.0 83.0 84.0 86.0 96.0 87.0 85.0 86.0 83.0 84.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:142.00 stddev:18.34 (12.9%) stddev-sans-first:19.45 12:01:35 INFO - PID 31494 | Values: 145.0 138.0 135.0 139.0 142.0 135.0 144.0 142.0 196.0 134.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:194.50 stddev:2.50 (1.3%) stddev-sans-first:2.60 12:01:35 INFO - PID 31494 | Values: 193.0 194.0 194.0 198.0 189.0 196.0 193.0 194.0 195.0 197.0 12:01:35 INFO - PID 31494 | 12:01:35 INFO - PID 31494 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:2.12 (2.9%) stddev-sans-first:2.24 12:01:35 INFO - PID 31494 | Values: 72.0 73.0 74.0 72.0 71.0 74.0 70.0 73.0 70.0 77.0 12:01:35 INFO - PID 31494 | -------- Summary: end -------- 12:01:35 INFO - PID 31494 | 12:01:36 INFO - TEST-INFO | 31494: exit 0 12:01:36 INFO - TEST-OK | kraken | took 64989ms 12:01:36 INFO - SUITE-END | took 1185s 12:01:37 INFO - Completed test suite (00:19:46) 12:01:37 INFO - javascript benchmark 12:01:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6648.210072735877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2688.9193324200273, 2726.754592086712, 2735.0153944579947, 2759.2274163234288, 2763.820351677141, 5230.79076836927, 5297.761600727967, 5316.468353164686, 5357.196420536921, 5365.892682146359, 5259.158534634459, 5282.154855223165, 5298.523132918037, 5377.193420986854, 5391.865203369918, 4811.25425559038, 4830.73430961297, 4852.975735121319, 4861.222204447289, 4863.416390033183, 4808.639352048593, 4835.5889749371345, 4897.265410188483, 4907.0, 4974.751262436882, 4743.31221972812, 4766.928496072562, 4799.1601469743, 4833.9033219335415, 4842.757862106881, 4775.331453596499, 4790.209615413452, 4800.927986080212, 4833.951660483421, 4849.418069831608, 4679.485256621769, 4750.192467280571, 4774.689645173053, 4787.234042553175, 4806.831760888352, 5112.565431938289, 5182.455842136559, 5226.503482169188, 5227.372715274153, 5294.285271488338, 5659.4340565943485, 5693.202951586781, 5734.856628584277, 5738.254026976508, 5750.626209296424, 5676.659400435987, 5698.572607054488, 5705.258316418881, 5707.429257074301, 5715.1713001614535, 5121.103806833789, 5270.367555893317, 5271.841844744664, 5280.762365693553, 5342.519173274424, 5718.828435146952, 5766.971165144231, 5768.826935191951, 5770.047942089592, 5772.04761214395, 5549.639273447213, 5587.525060369833, 5624.240727501735, 5635.013872572284, 5656.2929633795775, 5624.887502250014, 5689.601727879009, 5707.6575405475805, 5719.142128680731, 5722.256106706185, 5469.234307196995, 5606.6916319602815, 5626.437356264422, 5646.265985421951, 5651.971740141273, 5547.140193269969, 5636.943630563724, 5690.943090569124, 5719.456651618089, 5723.59934804568, 4773.618110551148, 4792.161371759928, 4795.064962332312, 4802.471728109905, 4833.492483289274, 4063.045184381668, 4084.9183016339507, 4085.55058943516, 4085.8978525536504, 4110.280700877394, 4760.238361862085, 4779.95220047802, 4828.203346447867, 4885.780139893714, 4891.9755401222765, 5686.3744988051285, 5726.513246374022, 5731.111677689882, 5741.913871291934, 5786.450287222707, 4849.418069831572, 4855.1260773061185, 4879.4388645305535, 4886.60907127429, 4903.01939612079, 4902.411710594752, 4961.032598643302, 4962.181240095416, 4979.551840334315, 5080.847574572768, 5207.505286997729, 5250.133727934848, 5257.0, 5259.395169555397, 5267.841964741064, 5625.915611265752, 5628.155776633538, 5634.183043458594, 5653.010723123519, 5718.142278658234, 5267.499587539178, 5305.787768489217, 5338.119210330407, 5338.97330513345, 5363.061464243664, 5540.806071787468, 5549.611527193058, 5555.0, 5557.277553917965, 5581.246531718329, 5569.805056822992, 5643.435656434323, 5677.886442271214, 5690.430956904276, 5766.509846663081, 5443.183522471661, 5469.3983661797965, 5475.72621368922, 5491.176323551499, 5494.505494505353, 5543.3902270751, 5563.833085007456, 5565.526930210977, 5568.192612071308, 5570.91643625354, 5358.383785864676, 5418.972905135607, 5462.098753705594, 5490.560755139659, 5520.1167813149705, 5510.035743744748, 5516.062269414129, 5559.11054231321, 5577.637453565505, 5594.0, 5432.049391356576, 5451.100568406168, 5452.991196628636, 5461.0, 5466.316710411199], "value": 5167.089162765713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.5795217204472, 668.7859884836853, 682.249525521926, 1187.5190547828126, 1200.2738343302308, 34768.82615586922, 35562.64437355626, 35770.0, 35818.0, 35917.461238081414, 32967.1758206045, 33236.16909577262, 33259.83370083152, 33516.16209594761, 33557.496637550394, 7363.226861179593, 7539.4345424093135, 7556.319931206191, 7565.2812982766545, 7573.356264717478, 7516.924830751677, 7571.6214189290595, 7616.771496855075, 7632.542047477142, 7662.923370766304, 7637.656305466267, 7664.348530374925, 7668.616569171519, 7669.6165191740465, 7701.152873183945, 7553.584552849591, 7604.0, 7620.3141717245435, 7622.618869056552, 7650.158482566913, 7425.034745483106, 7472.065991751031, 7504.962475187589, 7519.736809211706, 7526.661300241502, 33943.660563394544, 34259.31481370384, 34454.44954977032, 34465.483017754756, 34467.482987755204, 2546.987265063681, 2590.4689538644534, 2596.2470883443966, 2625.173070482792, 2627.8214753013654, 23918.521629567484, 23953.640695389582, 23971.40071498209, 24343.634845477332, 24395.512089758282, 2593.780922966203, 2600.6489123968213, 2606.491734111849, 2633.855137967411, 2646.8808903599192, 130910.0, 133699.33150334284, 159351.0, 159711.0, 159962.0, 39727.0, 40249.59750402517, 40298.79850600728, 40390.79804600958, 40409.0, 42340.0, 42464.78767606204, 42470.78764606219, 42540.0, 42552.87235638206, 12209.0, 12365.38173091342, 12372.07209459294, 12382.318972456422, 12392.442340094718, 9715.659951901649, 9731.610735570639, 9750.75623109428, 9792.853107203398, 9796.853047204298, 12935.805962910565, 12952.417141228667, 12986.0, 13003.804942925864, 13139.474421023053, 5459.617826752089, 5712.914306285409, 5736.942630573641, 5755.510781583528, 5777.6822274775295, 832.5712258187039, 869.248100393168, 870.9390342675952, 885.0132102705437, 895.3391458843881, 18380.448586542425, 19023.33418330352, 19342.4197274082, 19368.515787105436, 19592.314269000515, 972.6255391674115, 974.7270764186039, 981.66623348062, 984.6110786239395, 1000.1698590170287, 10077.193824494023, 10094.596216151273, 10373.896261037293, 10397.48012599367, 10474.109700675528, 240967.0, 242718.0, 242847.0, 242866.0, 243150.0, 41580.58419415828, 41713.58286417097, 41853.0, 41898.37152442716, 41918.58081419147, 1187.6615164678026, 1228.6744012836605, 1234.1422711215798, 1235.5428491458217, 1252.6242127361754, 17857.910710446366, 17940.434174436417, 18673.545394102133, 18850.0, 19188.520286992938, 29176.124716258546, 29423.55864661989, 29449.411011780074, 29459.705402945696, 29490.852545737132, 242767.0, 243763.0, 244099.0, 244408.0, 244744.0, 28546.0, 29485.705142949155, 30243.546346804374, 30295.242618934702, 30328.69671303347, 35727.0, 35730.46404303885, 36926.26147476982, 36968.44547331846, 37004.074898127765, 26891.0, 27287.454250914474, 27414.725852742016, 27546.0, 28731.712682872905, 27424.314392140357, 27616.723832761414, 28007.944527683176, 28224.435511289248, 28484.287892802018, 30089.398212035198, 30243.848780755954, 30388.39223215479, 30502.847485762428, 30862.228444289074, 26948.0, 27011.459770804868, 27037.0, 27179.72820271772, 28134.85932570324, 20553.0, 21795.891020544797, 21840.0, 22299.66550501776, 22377.216797412013], "value": 14812.454089114044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.98749037528887, 417.8119846069268, 426.878339673193, 433.9978300108499, 438.30966228190607, 17758.112094395277, 18053.63892722148, 18401.631967360663, 18547.16537755801, 18618.34835780748, 16413.507594772145, 16603.83396166038, 16726.66546669069, 17438.651226975486, 17495.0, 5588.552915766729, 5642.576806739501, 5712.542996560286, 5761.9135712964335, 5768.74040668171, 5686.0, 5759.136129580555, 5774.2782152230975, 5778.27771528559, 5782.190493330937, 5575.163725441196, 5695.857603559903, 5725.856853578653, 5733.197352370671, 5737.942620573783, 5686.658800471964, 5708.058170401879, 5713.914291285634, 5717.456841600062, 5719.14212868069, 4988.301637770715, 5096.79612815487, 5122.974385128051, 5134.383873935114, 5147.716875571842, 21668.783312166834, 22521.77478225213, 22536.774632253633, 22554.097836086537, 22715.545689086124, 1555.556661375325, 1588.602849287678, 1599.1045014791637, 1611.798525184352, 1624.8131464881571, 13594.524191653245, 14365.0, 14482.782758258634, 14721.92639036798, 14898.851011489964, 1645.1609679063645, 1679.8908070975347, 1713.3318005977678, 1717.467585048639, 1733.4539620019652, 87622.0, 88162.0, 89690.10309896883, 90349.54825225832, 98726.0, 19497.512562185777, 19650.312239071565, 19813.60372792536, 20221.393358198984, 20926.895365523076, 33255.0, 33301.3339733204, 33421.498677519856, 33512.0, 33685.32629347399, 8715.825683486295, 8792.120787921285, 8803.427777194462, 8898.911010889939, 9138.360314777901, 7111.395531379787, 7134.268537074107, 7320.560766354036, 7331.340179383881, 7333.1200255969625, 9196.218321442619, 9601.615935362646, 9804.852927206097, 9814.852777208347, 10096.869970309228, 3655.1958569114754, 3756.7370284079852, 3854.0750219947013, 3931.2137572485617, 3953.802309884494, 815.6939111082371, 854.8845905802636, 870.8214815962713, 875.0811647769816, 889.7330800759746, 15329.693406131815, 15572.68854622924, 15802.209889505479, 15848.0, 16381.754273685905, 868.2706526517629, 869.5782545465444, 870.8345414371249, 880.6345366672759, 901.2159421303508, 8604.655813767378, 8901.109889011048, 8910.643574257087, 9172.6789562365, 9214.35499515041, 447764.0, 479677.0, 486726.0, 489500.0, 497851.0, 89384.5530772355, 89387.0, 91482.0, 92718.0, 93922.53038734762, 1103.4868786014542, 1113.1484414422973, 1139.4245905817509, 1142.5429828068673, 1146.094585277638, 16238.756418653966, 16651.583710407336, 16922.915385423486, 17016.319347225974, 17248.223829927934, 40691.593084069966, 40811.38782918318, 41201.79399103105, 41741.0, 42166.36750448684, 50343.74828125836, 51807.0, 52657.473425265256, 53950.0, 54017.0, 7950.40371972116, 8058.234467725557, 8106.39202059836, 8153.6330865112395, 8191.508509489449, 11945.343006134399, 12003.63989080329, 12140.392980351124, 12396.442160102637, 12515.311657858905, 10701.090407315465, 10785.406802625617, 10940.781184376427, 10994.505247263733, 11106.944465277622, 10339.844902326622, 10656.680299591024, 10809.783804324026, 11001.339919604528, 11041.171912106463, 10632.681019569425, 10695.465226738477, 10753.569857205624, 10963.835542467028, 11280.49237784318, 8071.556064416513, 8091.8381632365845, 8153.714619988272, 8173.509589424653, 8252.83494330122, 10634.14926805869, 10634.574617015542, 10659.573617055232, 10793.946030269799, 11169.162312826407], "value": 9558.206142863244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.0890772005735, 1340.209276526849, 1362.3801170467439, 1363.1820907455522, 1368.6031050995211, 9458.0, 9679.467629280387, 9841.015898410164, 9853.408795472267, 9989.450580218085, 9632.084951929573, 9814.50927453628, 9817.0, 9823.901760982388, 9830.655927042555, 2171.478845077182, 2214.081156320125, 2214.5792299463133, 2217.079911836586, 2219.2343641443676, 2123.225022866658, 2157.374361435182, 2161.8919054047315, 2199.087378737822, 2209.5359974405396, 2122.790009694475, 2176.281826997087, 2188.245055455865, 2192.1012384922187, 2204.305643722222, 2138.1340557074254, 2153.364757396572, 2154.806067453921, 2156.4393257753018, 2157.244964262511, 2082.187946700788, 2118.2374345235703, 2192.1669765489173, 2200.658897870833, 2200.7249093863265, 9675.371100878421, 9689.70930872075, 9756.414615123116, 9765.169960553361, 9772.26707996896, 5324.4675532446445, 5471.343438787331, 5489.0, 5513.228148059235, 5523.475269849358, 3207.7433805295755, 3387.6104248011547, 3390.4744764561533, 3390.830458477091, 3471.89584312471, 1011.3628414099144, 1033.8035773203067, 1054.114543783218, 1057.6351158850184, 1075.8547596074586, 13963.65090872726, 14076.085054471427, 14108.929455352658, 14166.645833854132, 14221.786673199911, 4696.530346965276, 4784.114938736345, 4955.108080545537, 4958.528939750718, 4972.453030166679, 10330.121939635215, 10370.688879333633, 10372.11836993849, 10398.064174224204, 10467.110295624958, 5280.498352656491, 5376.032314183484, 5378.220158077057, 5378.704171270618, 5385.542228910586, 4741.004389078332, 4846.442659094178, 4875.609951203895, 4992.675476094042, 5015.448300686921, 3738.476613274144, 3898.2203559288255, 3913.3542965410957, 3971.212954170635, 4013.8996525087105, 1162.6802629276847, 1165.7377090154648, 1175.6179241746468, 1199.0, 1202.008343116932, 687.0964681443985, 689.9586024838526, 698.4377576051328, 704.2183176673888, 711.4877288352378, 5239.292695486137, 5244.003639308519, 5272.525472707474, 5277.551408130275, 5380.1929710542945, 545.555372371516, 559.7089513452981, 564.2044716949082, 564.3538148819579, 573.8077743955738, 3380.7295416366633, 3491.633378495272, 3522.5068490411363, 3584.5160903277724, 3603.6396360363756, 12054.216475929037, 12758.298293593942, 12780.297083660302, 12782.872171278354, 12786.360681965865, 12299.262044277371, 12367.505299787908, 12624.495020199272, 12627.368631568384, 12661.303628300531, 9131.817363652823, 9147.679831205876, 9256.95371523138, 9299.34904556688, 9326.207272381787, 5305.439164759845, 5320.388155362183, 5372.355317361941, 5442.102053161184, 5536.114221724505, 11167.867190773628, 11317.490712918103, 11376.374299413612, 11400.48697808584, 11421.828672570084, 11585.6524304271, 11601.071914247008, 11712.590059347882, 11733.237339572901, 11742.471588778355, 7344.632768361667, 7459.067616547932, 7471.663775130023, 7471.6637751302405, 7917.089534703583, 9297.488638124969, 9302.395344302598, 9368.578413971523, 9394.530273486434, 9425.481598512148, 7313.817154570966, 7419.888701669587, 7494.925050749423, 7541.585212813128, 7639.236076392539, 7412.0, 7451.143118541437, 7510.361619262424, 7528.811779705551, 7762.3790096793255, 6643.900341494978, 6657.367550082734, 6687.164104486939, 6766.7969960901255, 6771.762988295386, 4764.0, 4945.826896058621, 5001.799928002839, 5015.724135172454, 5052.797888084436, 4839.7096174229655, 4902.264660300983, 4947.208446648663, 4999.800007999639, 5029.798808047637], "value": 4553.629286066974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.3735598905817, 384.3964974989267, 390.80069164726, 394.07392627325805, 397.20360676842927, 5460.088968860897, 5651.3218413790355, 5679.460451257134, 5718.77124915004, 5734.512566431853, 5413.458654134584, 5506.752196151173, 5510.531604813586, 5512.779488820443, 5525.171224316355, 4275.850345237917, 4277.230098582262, 4280.464941882265, 4286.549912259199, 4303.085127118434, 4196.370544418346, 4209.452771139763, 4223.303154979425, 4293.184294983958, 4307.181635489263, 4184.581541845806, 4204.1801848639525, 4215.52456640175, 4217.325227963526, 4221.620054195122, 4209.810558524874, 4223.260929337369, 4226.260404429213, 4228.703990720651, 4260.70175087744, 3711.7030637548933, 3727.2545490901657, 3732.720045996561, 3733.2533493301175, 3736.3648179809497, 5241.318628578299, 5313.57491400687, 5342.435630897191, 5371.516563509303, 5403.594730395197, 4832.782524786393, 4843.782029808667, 4849.781759820817, 4864.513548645143, 4887.120318342697, 5582.106862901916, 5777.277840269966, 5788.913166302509, 5796.652200867961, 5804.62269952456, 4016.7589944603124, 4045.696572757055, 4056.310427227349, 4070.1859628074208, 4071.389291606253, 5976.581639285252, 6120.877582448326, 6158.507319414436, 6173.876522469525, 6188.721507532126, 4099.795010249476, 4123.134141830249, 4124.628783409507, 4141.171765646823, 4141.378793180987, 4181.226473102486, 4183.3515805050265, 4190.497140343178, 4190.51809041964, 4191.97904010478, 4753.0, 4789.0, 4807.206810876166, 4827.927581086286, 4841.903161936812, 5773.0, 5786.971065144648, 5800.303963524404, 5805.187273781674, 5808.361080281165, 1443.2711480702178, 1449.173970836613, 1450.0936914428482, 1451.75320195567, 1452.2738630684657, 934.3100517846349, 983.7343917142332, 987.8096893243625, 994.6121012805012, 996.1681995533811, 5065.240213967934, 5065.974670126626, 5068.302118790173, 5069.543741063322, 5098.745062746848, 5992.161097446361, 6094.3545242785085, 6104.847378815476, 6108.205933228652, 6122.448979591858, 4908.680935739237, 5044.1677123274985, 5073.543381095719, 5099.23511473282, 5111.616628752859, 3193.888213912502, 3223.065311059813, 3232.3050544133125, 3234.692704193098, 3252.577164968539, 5494.203340515603, 5629.943700563023, 5632.662040277596, 5639.577031722637, 5668.291463567054, 6071.150038994544, 6096.664683442454, 6155.0, 6158.538109641795, 6173.969130154321, 5574.275344205227, 5595.468430499096, 5628.802991895264, 5630.662160270315, 5642.520385767091, 5841.532677385884, 5995.520358371233, 6022.36278065878, 6032.0, 6040.728167232397, 5948.37542058095, 5963.52291816645, 5964.165016897725, 5969.641821490724, 5977.462028417463, 5342.78628854857, 5419.160030195326, 5467.617266791286, 5550.139728342114, 5617.887642247214, 4122.237386083464, 4132.276851551027, 4136.110736191733, 4146.896327591834, 4149.6472799811145, 5805.506531944832, 6016.819495415145, 6040.939590604214, 6058.182145410313, 6071.483923866344, 5782.971085144547, 5829.271341082364, 5830.1140935235635, 5868.2664666916635, 5869.530437564899, 5816.487713194684, 5839.211706419749, 5844.298684157929, 5853.887761325334, 5859.824205273849, 5640.492355687844, 5730.398308177581, 5758.165066065313, 5760.395158508464, 5761.56788240892, 5887.116932460165, 5894.322152952293, 5900.173975643327, 5901.852453688693, 5921.2006379138265, 5595.6985378626805, 5713.400092990342, 5718.1708652246025, 5736.225609542658, 5743.396943320891], "value": 4370.170270763664, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.0, 605.3885575568677, 614.9300217621338, 624.8750249950006, 636.3318515558665, 13331.466741330347, 13544.59366219015, 13805.51680691176, 13991.790123148148, 13992.230427326505, 13777.0, 13821.861781382184, 13858.514951976684, 13872.653183670389, 13966.231857247847, 653.3694984340111, 660.2638058564689, 906.8322360363321, 909.854423292275, 936.9718908432724, 937.6858752317981, 941.9246460283196, 944.1455482788053, 946.6828612414849, 948.4451595816456, 988.1107003696694, 988.3921388346188, 988.6836212412031, 993.2401712689798, 995.5967833027636, 970.5972021611022, 971.5822196455522, 971.7133445633519, 973.1873885305778, 981.4552923127661, 720.4488566246825, 725.5139056831882, 727.2073439950426, 729.9890501642479, 730.3426915775791, 13062.34688265583, 13286.3356832158, 14132.152070875678, 14325.856741432557, 14469.493567725185, 11448.255863368937, 13137.211767293993, 13361.997850161277, 13409.46362145513, 13497.865021349759, 9010.639574417015, 9061.773455663595, 9134.406263592911, 9152.359334846564, 9472.387518502692, 2319.686842276288, 2339.087755775249, 2396.700412448444, 2410.843295185807, 2411.5297516984197, 59993.400065999216, 61010.694946524985, 61304.0, 61508.077378839356, 62268.68865655688, 9131.178193962574, 9265.397749146285, 9271.258299336037, 9325.393849399903, 9713.757156071013, 20133.295334663217, 20150.0, 20166.19335226604, 20170.0, 20261.189552417738, 5712.65724056558, 5723.084306510938, 5747.0, 5873.4126587340925, 5956.047032474783, 2912.88348466059, 2915.1691767846487, 2919.5038242302526, 2931.311141881656, 2956.3496030873175, 3252.593425821772, 3283.622383425889, 3324.1523411529906, 3352.379809735207, 3373.241020770356, 592.925884264467, 594.5956749410442, 608.0605464557269, 609.960352577081, 617.1853153836981, 410.8274524699633, 412.36495796473696, 423.5531514252432, 432.5695932547136, 444.73316010394154, 7064.92935070653, 7336.7798966031105, 7601.619919004138, 7615.314621684075, 7650.540967541965, 449.29685042907744, 459.3890126132236, 459.59325996493345, 468.26482422596195, 481.7904211667936, 3242.1084201844683, 3275.1157187559224, 3357.093584732109, 3371.8314084296176, 3515.6132825389186, 59511.0, 59611.0, 60433.39566604366, 60994.69502652458, 61516.38483615196, 52589.7370513145, 53048.73475632597, 53684.19473707898, 53968.460315397126, 54884.451155488736, 49899.25151122736, 49994.75023623946, 50323.496765032614, 50645.746771265905, 51029.74485127625, 6658.1344425224415, 6821.727130914906, 6843.213030501556, 6861.622610756456, 6967.0, 23952.88023559871, 24287.51424971526, 24893.87553062223, 25692.229233123035, 27247.45505089927, 40369.0, 41020.1795964085, 41446.79276603598, 42145.578544214164, 44201.33697994468, 10841.783164336512, 11100.111991040536, 11146.164037697366, 11187.664370068911, 11377.829332559853, 11053.392063436588, 11234.708008579119, 11524.539018439169, 11707.707307317385, 12137.332446715161, 10241.897581024392, 10577.259591828499, 10626.149908007186, 11075.113990880549, 11239.157063220127, 11074.39090850011, 11219.04270519134, 11247.156463265452, 11306.886931130583, 11746.236494627821, 9761.951190244003, 9876.35803672759, 9983.750406239902, 10429.061384475433, 10436.791264174522, 7979.5611241382285, 8059.637316320897, 8311.501309921425, 8379.748607541784, 8391.664333426594, 8960.283177345666, 9166.404183728037, 9189.540522973959, 9290.16388525036, 9329.933038044413], "value": 5930.457263429092, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 174.0, 127.0, 127.0, 125.0, 131.0, 145.0, 127.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 167.0, 173.0, 168.0, 170.0, 175.0, 167.0, 168.0, 164.0], "value": 168.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 107.0, 78.0, 76.0, 76.0, 76.0, 98.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 107.0, 85.0, 85.0, 85.0, 97.0, 85.0, 86.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 120.0, 115.0, 114.0, 117.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 153.0, 150.0, 151.0, 151.0, 152.0, 152.0, 152.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 68.0, 68.0, 70.0, 68.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 83.0, 84.0, 86.0, 96.0, 87.0, 85.0, 86.0, 83.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 135.0, 139.0, 142.0, 135.0, 144.0, 142.0, 196.0, 134.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 194.0, 194.0, 198.0, 189.0, 196.0, 193.0, 194.0, 195.0, 197.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 72.0, 71.0, 74.0, 70.0, 73.0, 70.0, 77.0], "value": 72.6, "unit": "score"}]}]} 12:01:37 INFO - Return code: 0 12:01:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:01:37 ERROR - # TBPL SUCCESS # 12:01:37 INFO - Running post-action listener: _resource_record_post_action 12:01:37 INFO - [mozharness: 2017-03-30 19:01:37.423145Z] Finished run-tests step (success) 12:01:37 INFO - Running post-run listener: _resource_record_post_run 12:01:37 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366899200; Read time: 8; Write time: 272544 12:01:37 INFO - TinderboxPrint: CPU usage
13.3% 12:01:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:01:37 INFO - TinderboxPrint: I/O write bytes / time
366,899,200 / 272,544 12:01:37 INFO - TinderboxPrint: CPU idle
8,311.6 (86.6%) 12:01:37 INFO - TinderboxPrint: CPU user
1,222.8 (12.7%) 12:01:37 INFO - TinderboxPrint: Swap in / out
0 / 0 12:01:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105836544; Read time: 0; Write time: 80500 12:01:37 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261062656; Read time: 8; Write time: 192044 12:01:38 INFO - Running post-run listener: _upload_blobber_files 12:01:38 INFO - Blob upload gear active. 12:01:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:01:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:01:38 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:01:38 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:01:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:01:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:01:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:39 INFO - (blobuploader) - INFO - Done attempting. 12:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:40 INFO - (blobuploader) - INFO - Done attempting. 12:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:43 INFO - (blobuploader) - INFO - Done attempting. 12:01:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:01:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:01:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:44 INFO - (blobuploader) - INFO - Done attempting. 12:01:44 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:44 INFO - Return code: 0 12:01:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74422ec1a9d0a27043556a1a59a2f03a17c13a4234cc3d42aaf18dc5864cd0a2d6f917dc64077ae003a3715b61473be3e1137858f64a400440e1b47b5c204398", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/991cd4211cd6e18f0c8a236cff2eb76bc22a80ead73a38fcaddbe54b1235cabe1aaa79f55f08c23198edbca486f83e10dfd77f60d8f55d4ac87975a7544272ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9e52ceec341e2e6d99708c239bfdc963438a2d229eba87a4a5825de477c5d48036322e5887151b83954a1de61efc08813658a2c2bf3b6241f2748f3023516e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54a22c217acef572997a0244c75305383b718b2dbde2c5a8f43aa1903acff38a89b45e35cb635cbb7da6e2fa0f8c095e6664d5391e87ccd08447eb0cab1cce0a"} 12:01:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:44 INFO - Contents: 12:01:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74422ec1a9d0a27043556a1a59a2f03a17c13a4234cc3d42aaf18dc5864cd0a2d6f917dc64077ae003a3715b61473be3e1137858f64a400440e1b47b5c204398", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/991cd4211cd6e18f0c8a236cff2eb76bc22a80ead73a38fcaddbe54b1235cabe1aaa79f55f08c23198edbca486f83e10dfd77f60d8f55d4ac87975a7544272ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9e52ceec341e2e6d99708c239bfdc963438a2d229eba87a4a5825de477c5d48036322e5887151b83954a1de61efc08813658a2c2bf3b6241f2748f3023516e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54a22c217acef572997a0244c75305383b718b2dbde2c5a8f43aa1903acff38a89b45e35cb635cbb7da6e2fa0f8c095e6664d5391e87ccd08447eb0cab1cce0a"} 12:01:44 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:44 INFO - Copying logs to upload dir... 12:01:44 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.360673 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-30 12:01:44.063101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:44.066738) ========= 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=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74422ec1a9d0a27043556a1a59a2f03a17c13a4234cc3d42aaf18dc5864cd0a2d6f917dc64077ae003a3715b61473be3e1137858f64a400440e1b47b5c204398", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/991cd4211cd6e18f0c8a236cff2eb76bc22a80ead73a38fcaddbe54b1235cabe1aaa79f55f08c23198edbca486f83e10dfd77f60d8f55d4ac87975a7544272ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9e52ceec341e2e6d99708c239bfdc963438a2d229eba87a4a5825de477c5d48036322e5887151b83954a1de61efc08813658a2c2bf3b6241f2748f3023516e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54a22c217acef572997a0244c75305383b718b2dbde2c5a8f43aa1903acff38a89b45e35cb635cbb7da6e2fa0f8c095e6664d5391e87ccd08447eb0cab1cce0a"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74422ec1a9d0a27043556a1a59a2f03a17c13a4234cc3d42aaf18dc5864cd0a2d6f917dc64077ae003a3715b61473be3e1137858f64a400440e1b47b5c204398", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/991cd4211cd6e18f0c8a236cff2eb76bc22a80ead73a38fcaddbe54b1235cabe1aaa79f55f08c23198edbca486f83e10dfd77f60d8f55d4ac87975a7544272ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9e52ceec341e2e6d99708c239bfdc963438a2d229eba87a4a5825de477c5d48036322e5887151b83954a1de61efc08813658a2c2bf3b6241f2748f3023516e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54a22c217acef572997a0244c75305383b718b2dbde2c5a8f43aa1903acff38a89b45e35cb635cbb7da6e2fa0f8c095e6664d5391e87ccd08447eb0cab1cce0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:44.092430) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:44.092757) ========= 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=836cfdc75598d54cb747368e000001a9-1490897726.497805-714358296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:44.175149) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 12:01:44.175455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 12:01:44.175762) ========= ========= Total master_lag: 0.16 =========