builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1484042076.35 results: success (0) revision: a61edc75cfb522ad1a87bb2be1e1419049361ac4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.353297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.354158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.354434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.413173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.413448) ========= 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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 01:54:36-- 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% 222M=0s 2017-01-10 01:54:36 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.572301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.572648) ========= 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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:36.621746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 01:54:36.622106) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev a61edc75cfb522ad1a87bb2be1e1419049361ac4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev a61edc75cfb522ad1a87bb2be1e1419049361ac4 --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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 01:54:36,694 truncating revision to first 12 chars 2017-01-10 01:54:36,694 Setting DEBUG logging. 2017-01-10 01:54:36,694 attempt 1/10 2017-01-10 01:54:36,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/a61edc75cfb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 01:54:37,880 unpacking tar archive at: graphics-a61edc75cfb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.539303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 01:54:38.174653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.174963) ========= script_repo_revision: a61edc75cfb522ad1a87bb2be1e1419049361ac4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.175400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.175666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 01:54:38.183813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-10 01:54:38.184120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:54:38 INFO - MultiFileLogger online at 20170110 01:54:38 in /builds/slave/test 01:54:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 01:54:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:38 INFO - {'append_to_log': False, 01:54:38 INFO - 'base_work_dir': '/builds/slave/test', 01:54:38 INFO - 'blob_upload_branch': 'Graphics', 01:54:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:38 INFO - 'branch': 'Graphics', 01:54:38 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:38 INFO - 'config_files': ('talos/linux_config.py',), 01:54:38 INFO - 'default_actions': ('clobber', 01:54:38 INFO - 'read-buildbot-config', 01:54:38 INFO - 'download-and-extract', 01:54:38 INFO - 'populate-webroot', 01:54:38 INFO - 'create-virtualenv', 01:54:38 INFO - 'install', 01:54:38 INFO - 'run-tests'), 01:54:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:38 INFO - 'download_minidump_stackwalk': True, 01:54:38 INFO - 'download_symbols': 'ondemand', 01:54:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:38 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:38 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:38 INFO - 'installer_path': 'installer.exe', 01:54:38 INFO - 'log_level': 'info', 01:54:38 INFO - 'log_name': 'talos', 01:54:38 INFO - 'log_to_console': True, 01:54:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:54:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:54:38 INFO - 'opt_config_files': (), 01:54:38 INFO - 'pip_index': False, 01:54:38 INFO - 'sps_profile': False, 01:54:38 INFO - 'sps_profile_interval': 0, 01:54:38 INFO - 'suite': 'dromaeojs', 01:54:38 INFO - 'system_bits': '32', 01:54:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:38 INFO - 'title': 'talos-linux64-ix-039', 01:54:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:38 INFO - 'use_talos_json': True, 01:54:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:38 INFO - 'work_dir': 'build'} 01:54:38 INFO - [mozharness: 2017-01-10 09:54:38.353999Z] Running clobber step. 01:54:38 INFO - Running pre-action listener: _resource_record_pre_action 01:54:38 INFO - Running main action method: clobber 01:54:38 INFO - rmtree: /builds/slave/test/build 01:54:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:38 INFO - Running post-action listener: _resource_record_post_action 01:54:38 INFO - [mozharness: 2017-01-10 09:54:38.809005Z] Finished clobber step (success) 01:54:38 INFO - [mozharness: 2017-01-10 09:54:38.809121Z] Running read-buildbot-config step. 01:54:38 INFO - Running pre-action listener: _resource_record_pre_action 01:54:38 INFO - Running main action method: read_buildbot_config 01:54:38 INFO - Using buildbot properties: 01:54:38 INFO - { 01:54:38 INFO - "project": "", 01:54:38 INFO - "product": "firefox", 01:54:38 INFO - "who": "nsilva@mozilla.com", 01:54:38 INFO - "installer_path": "public/build/target.tar.bz2", 01:54:38 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 01:54:38 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 01:54:38 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 01:54:38 INFO - "stage_platform": "linux64", 01:54:38 INFO - "basedir": "/builds/slave/test", 01:54:38 INFO - "buildnumber": 48, 01:54:38 INFO - "platform": "ubuntu64_hw", 01:54:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:54:38 INFO - "slavebuilddir": "test", 01:54:38 INFO - "taskId": "SY5K_7Y3Q66eoUMsqVcRpQ", 01:54:38 INFO - "branch": "graphics", 01:54:38 INFO - "script_repo_revision": "default", 01:54:38 INFO - "revision": "a61edc75cfb522ad1a87bb2be1e1419049361ac4", 01:54:38 INFO - "slavename": "talos-linux64-ix-039", 01:54:38 INFO - "repo_path": "projects/graphics" 01:54:38 INFO - } 01:54:38 INFO - Finding installer, test and symbols from parent task. 01:54:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SY5K_7Y3Q66eoUMsqVcRpQ'}, attempt #1 01:54:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SY5K_7Y3Q66eoUMsqVcRpQ'}, attempt #1 01:54:39 INFO - Task dependencies: GKsmARG4RIeFwTPkb8pH3g 01:54:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g'}, attempt #1 01:54:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/test_packages.json 01:54:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip 01:54:40 INFO - Running post-action listener: _resource_record_post_action 01:54:40 INFO - [mozharness: 2017-01-10 09:54:40.199035Z] Finished read-buildbot-config step (success) 01:54:40 INFO - [mozharness: 2017-01-10 09:54:40.199253Z] Running download-and-extract step. 01:54:40 INFO - Running pre-action listener: _resource_record_pre_action 01:54:40 INFO - Running main action method: download_and_extract 01:54:40 INFO - mkdir: /builds/slave/test/build/tests 01:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:54:40 INFO - trying https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json 01:54:40 INFO - Downloading https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:54:40 INFO - Downloaded 896 bytes. 01:54:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:54:40 INFO - Using the following test package requirements: 01:54:40 INFO - {u'common': [u'target.common.tests.zip'], 01:54:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:54:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:54:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:54:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:54:40 INFO - u'mozbase': [u'target.common.tests.zip'], 01:54:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:54:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:54:40 INFO - u'web-platform': [u'target.common.tests.zip', 01:54:40 INFO - u'target.web-platform.tests.zip'], 01:54:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:54:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:54:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip 01:54:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:54:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip into memory 01:54:41 INFO - Expected file size: 20251352 01:54:41 INFO - Obtained file size: 20251352 01:54:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:54:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip 01:54:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:54:45 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.common.tests.zip into memory 01:54:46 INFO - Expected file size: 20251352 01:54:46 INFO - Obtained file size: 20251352 01:54:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip 01:54:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:54:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.talos.tests.zip into memory 01:54:52 INFO - Expected file size: 14403537 01:54:52 INFO - Obtained file size: 14403537 01:54:52 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')]} 01:54:52 INFO - trying https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:52 INFO - Downloading https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:54:54 INFO - Downloaded 55923122 bytes. 01:54:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:54 INFO - mkdir: /builds/slave/test/properties 01:54:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:54:54 INFO - Writing to file /builds/slave/test/properties/build_url 01:54:54 INFO - Contents: 01:54:54 INFO - build_url:https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 01:54:54 INFO - Running post-action listener: _resource_record_post_action 01:54:54 INFO - Running post-action listener: set_extra_try_arguments 01:54:54 INFO - [mozharness: 2017-01-10 09:54:54.466508Z] Finished download-and-extract step (success) 01:54:54 INFO - [mozharness: 2017-01-10 09:54:54.466605Z] Running populate-webroot step. 01:54:54 INFO - Running pre-action listener: _resource_record_pre_action 01:54:54 INFO - Running main action method: populate_webroot 01:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:54:54 INFO - '--tppagecycles', 01:54:54 INFO - '7'], 01:54:54 INFO - 'tests': ['tsvgm']}}, 01:54:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:54:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:54:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:54:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:54:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['damp', 'tps']}, 01:54:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'tests': ['damp', 'tps']}, 01:54:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['dromaeo_dom']}, 01:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:54:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['basic_compositor_video']}, 01:54:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:54:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['a11yr', 01:54:54 INFO - 'ts_paint', 01:54:54 INFO - 'tpaint', 01:54:54 INFO - 'sessionrestore', 01:54:54 INFO - 'sessionrestore_no_auto_restore', 01:54:54 INFO - 'tabpaint']}, 01:54:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['tsvgx', 01:54:54 INFO - 'tsvgr_opacity', 01:54:54 INFO - 'tart', 01:54:54 INFO - 'tscrollx', 01:54:54 INFO - 'cart', 01:54:54 INFO - 'tsvg_static']}, 01:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:54:54 INFO - 'tsvgr_opacity', 01:54:54 INFO - 'tart', 01:54:54 INFO - 'tscrollx', 01:54:54 INFO - 'cart', 01:54:54 INFO - 'tsvg_static']}, 01:54:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'talos_options': ['--disable-e10s'], 01:54:54 INFO - 'tests': ['tp5o']}, 01:54:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:54:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'talos_options': ['--disable-e10s', 01:54:54 INFO - '--xperf_path', 01:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:54 INFO - 'tests': ['tp5n']}, 01:54:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:54:54 INFO - 'talos_options': ['--xperf_path', 01:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:54:54 INFO - 'tests': ['tp5n']}}, 01:54:54 INFO - 'talos.zip': {'path': '', 01:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:54:54 INFO - Running post-action listener: _resource_record_post_action 01:54:54 INFO - [mozharness: 2017-01-10 09:54:54.479769Z] Finished populate-webroot step (success) 01:54:54 INFO - [mozharness: 2017-01-10 09:54:54.479864Z] Running create-virtualenv step. 01:54:54 INFO - Running pre-action listener: _resource_record_pre_action 01:54:54 INFO - Running main action method: create_virtualenv 01:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:54:54 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 01:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:54:54 INFO - Using real prefix '/usr' 01:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:54:57 INFO - Installing pip.................done. 01:54:57 INFO - Return code: 0 01:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:54:57 INFO - Reading from file tmpfile_stdout 01:54:57 INFO - Output received: 01:54:57 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) 01:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:54:57 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')]} 01:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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')]} 01:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:54:57 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 01:54:57 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 01:54:57 INFO - Using env: {'DISPLAY': ':0', 01:54:57 INFO - 'HOME': '/home/cltbld', 01:54:57 INFO - 'LANG': 'en_US.UTF-8', 01:54:57 INFO - 'LANGUAGE': 'en_US:en', 01:54:57 INFO - 'LOGNAME': 'cltbld', 01:54:57 INFO - 'MAIL': '/var/mail/cltbld', 01:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:57 INFO - 'MOZ_NO_REMOTE': '1', 01:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:57 INFO - 'NO_EM_RESTART': '1', 01:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:57 INFO - 'PWD': '/builds/slave/test', 01:54:57 INFO - 'SHELL': '/bin/bash', 01:54:57 INFO - 'SHLVL': '1', 01:54:57 INFO - 'TERM': 'linux', 01:54:57 INFO - 'TMOUT': '86400', 01:54:57 INFO - 'USER': 'cltbld', 01:54:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:57 INFO - '_': '/tools/buildbot/bin/python'} 01:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:57 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 01:54:57 INFO - Cleaning up... 01:54:57 INFO - Return code: 0 01:54:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:54:57 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')]} 01:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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')]} 01:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:57 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:54:57 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 01:54:57 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 01:54:57 INFO - Using env: {'DISPLAY': ':0', 01:54:57 INFO - 'HOME': '/home/cltbld', 01:54:57 INFO - 'LANG': 'en_US.UTF-8', 01:54:57 INFO - 'LANGUAGE': 'en_US:en', 01:54:57 INFO - 'LOGNAME': 'cltbld', 01:54:57 INFO - 'MAIL': '/var/mail/cltbld', 01:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:57 INFO - 'MOZ_NO_REMOTE': '1', 01:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:57 INFO - 'NO_EM_RESTART': '1', 01:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:54:57 INFO - 'PWD': '/builds/slave/test', 01:54:57 INFO - 'SHELL': '/bin/bash', 01:54:57 INFO - 'SHLVL': '1', 01:54:57 INFO - 'TERM': 'linux', 01:54:57 INFO - 'TMOUT': '86400', 01:54:57 INFO - 'USER': 'cltbld', 01:54:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:57 INFO - '_': '/tools/buildbot/bin/python'} 01:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:57 INFO - Downloading/unpacking psutil>=3.1.1 01:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:54:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:54:59 INFO - Installing collected packages: psutil 01:54:59 INFO - Running setup.py install for psutil 01:54:59 INFO - building 'psutil._psutil_linux' extension 01:54:59 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 01:55:00 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 01:55:00 INFO - building 'psutil._psutil_posix' extension 01:55:00 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 01:55:00 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 01:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:00 INFO - Successfully installed psutil 01:55:00 INFO - Cleaning up... 01:55:00 INFO - Return code: 0 01:55:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:00 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:00 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 01:55:00 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 01:55:00 INFO - Using env: {'DISPLAY': ':0', 01:55:00 INFO - 'HOME': '/home/cltbld', 01:55:00 INFO - 'LANG': 'en_US.UTF-8', 01:55:00 INFO - 'LANGUAGE': 'en_US:en', 01:55:00 INFO - 'LOGNAME': 'cltbld', 01:55:00 INFO - 'MAIL': '/var/mail/cltbld', 01:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:00 INFO - 'MOZ_NO_REMOTE': '1', 01:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:00 INFO - 'NO_EM_RESTART': '1', 01:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:00 INFO - 'PWD': '/builds/slave/test', 01:55:00 INFO - 'SHELL': '/bin/bash', 01:55:00 INFO - 'SHLVL': '1', 01:55:00 INFO - 'TERM': 'linux', 01:55:00 INFO - 'TMOUT': '86400', 01:55:00 INFO - 'USER': 'cltbld', 01:55:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:00 INFO - '_': '/tools/buildbot/bin/python'} 01:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:55:00 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 01:55:00 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 01:55:00 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 01:55:00 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 01:55:00 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 01:55:00 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 01:55:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:55:02 INFO - Installing collected packages: mozsystemmonitor 01:55:02 INFO - Running setup.py install for mozsystemmonitor 01:55:02 INFO - Successfully installed mozsystemmonitor 01:55:02 INFO - Cleaning up... 01:55:02 INFO - Return code: 0 01:55:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:02 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:02 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 01:55:02 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 01:55:02 INFO - Using env: {'DISPLAY': ':0', 01:55:02 INFO - 'HOME': '/home/cltbld', 01:55:02 INFO - 'LANG': 'en_US.UTF-8', 01:55:02 INFO - 'LANGUAGE': 'en_US:en', 01:55:02 INFO - 'LOGNAME': 'cltbld', 01:55:02 INFO - 'MAIL': '/var/mail/cltbld', 01:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:02 INFO - 'MOZ_NO_REMOTE': '1', 01:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:02 INFO - 'NO_EM_RESTART': '1', 01:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:02 INFO - 'PWD': '/builds/slave/test', 01:55:02 INFO - 'SHELL': '/bin/bash', 01:55:02 INFO - 'SHLVL': '1', 01:55:02 INFO - 'TERM': 'linux', 01:55:02 INFO - 'TMOUT': '86400', 01:55:02 INFO - 'USER': 'cltbld', 01:55:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:02 INFO - '_': '/tools/buildbot/bin/python'} 01:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:55:03 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 01:55:03 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 01:55:03 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 01:55:03 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 01:55:03 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 01:55:03 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 01:55:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:05 INFO - warning: no files found matching '*.txt' 01:55:05 INFO - no previously-included directories found matching 'build' 01:55:05 INFO - no previously-included directories found matching 'dist' 01:55:05 INFO - no previously-included directories found matching '.git*' 01:55:05 INFO - Installing collected packages: jsonschema, functools32 01:55:05 INFO - Running setup.py install for functools32 01:55:05 INFO - warning: no files found matching '*.txt' 01:55:05 INFO - no previously-included directories found matching 'build' 01:55:05 INFO - no previously-included directories found matching 'dist' 01:55:05 INFO - no previously-included directories found matching '.git*' 01:55:05 INFO - Successfully installed jsonschema functools32 01:55:05 INFO - Cleaning up... 01:55:05 INFO - Return code: 0 01:55:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:05 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 01:55:05 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 01:55:05 INFO - Using env: {'DISPLAY': ':0', 01:55:05 INFO - 'HOME': '/home/cltbld', 01:55:05 INFO - 'LANG': 'en_US.UTF-8', 01:55:05 INFO - 'LANGUAGE': 'en_US:en', 01:55:05 INFO - 'LOGNAME': 'cltbld', 01:55:05 INFO - 'MAIL': '/var/mail/cltbld', 01:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:05 INFO - 'MOZ_NO_REMOTE': '1', 01:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:05 INFO - 'NO_EM_RESTART': '1', 01:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:05 INFO - 'PWD': '/builds/slave/test', 01:55:05 INFO - 'SHELL': '/bin/bash', 01:55:05 INFO - 'SHLVL': '1', 01:55:05 INFO - 'TERM': 'linux', 01:55:05 INFO - 'TMOUT': '86400', 01:55:05 INFO - 'USER': 'cltbld', 01:55:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:05 INFO - '_': '/tools/buildbot/bin/python'} 01:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:55:05 INFO - Cleaning up... 01:55:05 INFO - Return code: 0 01:55:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:05 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:05 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 01:55:05 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 01:55:05 INFO - Using env: {'DISPLAY': ':0', 01:55:05 INFO - 'HOME': '/home/cltbld', 01:55:05 INFO - 'LANG': 'en_US.UTF-8', 01:55:05 INFO - 'LANGUAGE': 'en_US:en', 01:55:05 INFO - 'LOGNAME': 'cltbld', 01:55:05 INFO - 'MAIL': '/var/mail/cltbld', 01:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:05 INFO - 'MOZ_NO_REMOTE': '1', 01:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:05 INFO - 'NO_EM_RESTART': '1', 01:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:05 INFO - 'PWD': '/builds/slave/test', 01:55:05 INFO - 'SHELL': '/bin/bash', 01:55:05 INFO - 'SHLVL': '1', 01:55:05 INFO - 'TERM': 'linux', 01:55:05 INFO - 'TMOUT': '86400', 01:55:05 INFO - 'USER': 'cltbld', 01:55:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:05 INFO - '_': '/tools/buildbot/bin/python'} 01:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:05 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 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 01:55:08 INFO - Downloading docopt-0.6.1.tar.gz 01:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:08 INFO - Running setup.py install for blobuploader 01:55:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:08 INFO - Running setup.py install for requests 01:55:09 INFO - Running setup.py install for docopt 01:55:09 INFO - Successfully installed blobuploader requests docopt 01:55:09 INFO - Cleaning up... 01:55:09 INFO - Return code: 0 01:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:09 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')]} 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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')]} 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:09 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 01:55:09 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 01:55:09 INFO - Using env: {'DISPLAY': ':0', 01:55:09 INFO - 'HOME': '/home/cltbld', 01:55:09 INFO - 'LANG': 'en_US.UTF-8', 01:55:09 INFO - 'LANGUAGE': 'en_US:en', 01:55:09 INFO - 'LOGNAME': 'cltbld', 01:55:09 INFO - 'MAIL': '/var/mail/cltbld', 01:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:09 INFO - 'MOZ_NO_REMOTE': '1', 01:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:09 INFO - 'NO_EM_RESTART': '1', 01:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:09 INFO - 'PWD': '/builds/slave/test', 01:55:09 INFO - 'SHELL': '/bin/bash', 01:55:09 INFO - 'SHLVL': '1', 01:55:09 INFO - 'TERM': 'linux', 01:55:09 INFO - 'TMOUT': '86400', 01:55:09 INFO - 'USER': 'cltbld', 01:55:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:09 INFO - '_': '/tools/buildbot/bin/python'} 01:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:09 INFO - Running setup.py (path:/tmp/pip-iMfKTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:09 INFO - Running setup.py (path:/tmp/pip-TTeSPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:09 INFO - Running setup.py (path:/tmp/pip-uXM1WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:09 INFO - Running setup.py (path:/tmp/pip-eSSRMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:09 INFO - Running setup.py (path:/tmp/pip-IIQXiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:09 INFO - Running setup.py (path:/tmp/pip-nNXSzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:10 INFO - Running setup.py (path:/tmp/pip-36VNHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:10 INFO - Running setup.py (path:/tmp/pip-tb88Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:10 INFO - Running setup.py (path:/tmp/pip-juxxPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:10 INFO - Running setup.py (path:/tmp/pip-n_hjKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:10 INFO - Running setup.py (path:/tmp/pip-Ue8hAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:10 INFO - Running setup.py (path:/tmp/pip-qznzp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:10 INFO - Running setup.py (path:/tmp/pip-KG01Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:10 INFO - Running setup.py (path:/tmp/pip-ItvO_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:10 INFO - Running setup.py (path:/tmp/pip-5N0HMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:10 INFO - Running setup.py (path:/tmp/pip-bfSXBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:10 INFO - Running setup.py (path:/tmp/pip-vT1nms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:10 INFO - Running setup.py install for manifestparser 01:55:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:10 INFO - Running setup.py install for mozcrash 01:55:11 INFO - Running setup.py install for mozdebug 01:55:11 INFO - Running setup.py install for mozdevice 01:55:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozfile 01:55:11 INFO - Running setup.py install for mozhttpd 01:55:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozinfo 01:55:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozInstall 01:55:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozleak 01:55:11 INFO - Running setup.py install for mozlog 01:55:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for moznetwork 01:55:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:11 INFO - Running setup.py install for mozprocess 01:55:12 INFO - Running setup.py install for mozprofile 01:55:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozrunner 01:55:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Running setup.py install for mozscreenshot 01:55:12 INFO - Running setup.py install for moztest 01:55:12 INFO - Running setup.py install for mozversion 01:55:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:12 INFO - Cleaning up... 01:55:12 INFO - Return code: 0 01:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:12 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')]} 01:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:12 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')]} 01:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:12 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:12 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 01:55:12 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 01:55:12 INFO - Using env: {'DISPLAY': ':0', 01:55:12 INFO - 'HOME': '/home/cltbld', 01:55:12 INFO - 'LANG': 'en_US.UTF-8', 01:55:12 INFO - 'LANGUAGE': 'en_US:en', 01:55:12 INFO - 'LOGNAME': 'cltbld', 01:55:12 INFO - 'MAIL': '/var/mail/cltbld', 01:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:12 INFO - 'MOZ_NO_REMOTE': '1', 01:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:12 INFO - 'NO_EM_RESTART': '1', 01:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:12 INFO - 'PWD': '/builds/slave/test', 01:55:12 INFO - 'SHELL': '/bin/bash', 01:55:12 INFO - 'SHLVL': '1', 01:55:12 INFO - 'TERM': 'linux', 01:55:12 INFO - 'TMOUT': '86400', 01:55:12 INFO - 'USER': 'cltbld', 01:55:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:12 INFO - '_': '/tools/buildbot/bin/python'} 01:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:12 INFO - Running setup.py (path:/tmp/pip-pPBFGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:12 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)) 01:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:12 INFO - Running setup.py (path:/tmp/pip-IER2VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:13 INFO - Running setup.py (path:/tmp/pip-7FoVX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:13 INFO - Running setup.py (path:/tmp/pip-MFR8Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:13 INFO - Running setup.py (path:/tmp/pip-MBz6SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:13 INFO - Running setup.py (path:/tmp/pip-OUru42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:13 INFO - Running setup.py (path:/tmp/pip-rzEPav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:13 INFO - Running setup.py (path:/tmp/pip-xNiKhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:13 INFO - Running setup.py (path:/tmp/pip-HIK0ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:13 INFO - Running setup.py (path:/tmp/pip-HX_Gbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:13 INFO - Running setup.py (path:/tmp/pip-eoBRMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:13 INFO - Running setup.py (path:/tmp/pip-snBGb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:13 INFO - Running setup.py (path:/tmp/pip-bwFqDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:13 INFO - Running setup.py (path:/tmp/pip-5vecPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:13 INFO - Running setup.py (path:/tmp/pip-FkmwI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:13 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)) 01:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:13 INFO - Running setup.py (path:/tmp/pip-9NAkD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:14 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)) 01:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:14 INFO - Running setup.py (path:/tmp/pip-dn5L_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:14 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)) 01:55:14 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)) 01:55:14 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)) 01:55:14 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)) 01:55:14 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)) 01:55:14 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)) 01:55:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:14 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 01:55:14 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 01:55:14 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 01:55:14 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 01:55:14 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 01:55:14 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 01:55:16 INFO - Downloading blessings-1.6.tar.gz 01:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:16 INFO - Installing collected packages: blessings 01:55:16 INFO - Running setup.py install for blessings 01:55:16 INFO - Successfully installed blessings 01:55:16 INFO - Cleaning up... 01:55:16 INFO - Return code: 0 01:55:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:16 INFO - Reading from file tmpfile_stdout 01:55:16 INFO - Current package versions: 01:55:16 INFO - argparse == 1.2.1 01:55:16 INFO - blessings == 1.6 01:55:16 INFO - blobuploader == 1.2.4 01:55:16 INFO - docopt == 0.6.1 01:55:16 INFO - functools32 == 3.2.3-2 01:55:16 INFO - jsonschema == 2.5.1 01:55:16 INFO - manifestparser == 1.1 01:55:16 INFO - mozInstall == 1.12 01:55:16 INFO - mozcrash == 1.0 01:55:16 INFO - mozdebug == 0.1 01:55:16 INFO - mozdevice == 0.49 01:55:16 INFO - mozfile == 1.2 01:55:16 INFO - mozhttpd == 0.7 01:55:16 INFO - mozinfo == 0.9 01:55:16 INFO - mozleak == 0.1 01:55:16 INFO - mozlog == 3.4 01:55:16 INFO - moznetwork == 0.27 01:55:16 INFO - mozprocess == 0.24 01:55:16 INFO - mozprofile == 0.28 01:55:16 INFO - mozrunner == 6.13 01:55:16 INFO - mozscreenshot == 0.1 01:55:16 INFO - mozsystemmonitor == 0.3 01:55:16 INFO - moztest == 0.8 01:55:16 INFO - mozversion == 1.4 01:55:16 INFO - psutil == 3.1.1 01:55:16 INFO - requests == 1.2.3 01:55:16 INFO - wsgiref == 0.1.2 01:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:16 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')]} 01:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:16 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')]} 01:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:16 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:16 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 01:55:16 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 01:55:16 INFO - Using env: {'DISPLAY': ':0', 01:55:16 INFO - 'HOME': '/home/cltbld', 01:55:16 INFO - 'LANG': 'en_US.UTF-8', 01:55:16 INFO - 'LANGUAGE': 'en_US:en', 01:55:16 INFO - 'LOGNAME': 'cltbld', 01:55:16 INFO - 'MAIL': '/var/mail/cltbld', 01:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:16 INFO - 'MOZ_NO_REMOTE': '1', 01:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:16 INFO - 'NO_EM_RESTART': '1', 01:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:16 INFO - 'PWD': '/builds/slave/test', 01:55:16 INFO - 'SHELL': '/bin/bash', 01:55:16 INFO - 'SHLVL': '1', 01:55:16 INFO - 'TERM': 'linux', 01:55:16 INFO - 'TMOUT': '86400', 01:55:16 INFO - 'USER': 'cltbld', 01:55:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:16 INFO - '_': '/tools/buildbot/bin/python'} 01:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 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)) 01:55:16 INFO - Cleaning up... 01:55:16 INFO - Return code: 0 01:55:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:55:16 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')]} 01:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:16 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')]} 01:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:16 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 0xdf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116ac70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', '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 01:55:16 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 01:55:16 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 01:55:16 INFO - Using env: {'DISPLAY': ':0', 01:55:16 INFO - 'HOME': '/home/cltbld', 01:55:16 INFO - 'LANG': 'en_US.UTF-8', 01:55:16 INFO - 'LANGUAGE': 'en_US:en', 01:55:16 INFO - 'LOGNAME': 'cltbld', 01:55:16 INFO - 'MAIL': '/var/mail/cltbld', 01:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:16 INFO - 'MOZ_NO_REMOTE': '1', 01:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:16 INFO - 'NO_EM_RESTART': '1', 01:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:16 INFO - 'PWD': '/builds/slave/test', 01:55:16 INFO - 'SHELL': '/bin/bash', 01:55:16 INFO - 'SHLVL': '1', 01:55:16 INFO - 'TERM': 'linux', 01:55:16 INFO - 'TMOUT': '86400', 01:55:16 INFO - 'USER': 'cltbld', 01:55:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:16 INFO - '_': '/tools/buildbot/bin/python'} 01:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:55:17 INFO - Cleaning up... 01:55:17 INFO - Return code: 0 01:55:17 INFO - Running post-action listener: _resource_record_post_action 01:55:17 INFO - Running post-action listener: _start_resource_monitoring 01:55:17 INFO - Starting resource monitoring. 01:55:17 INFO - [mozharness: 2017-01-10 09:55:17.130238Z] Finished create-virtualenv step (success) 01:55:17 INFO - [mozharness: 2017-01-10 09:55:17.130692Z] Running install step. 01:55:17 INFO - Running pre-action listener: _resource_record_pre_action 01:55:17 INFO - Running main action method: install 01:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:17 INFO - Reading from file tmpfile_stdout 01:55:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:17 INFO - Reading from file tmpfile_stdout 01:55:17 INFO - Output received: 01:55:17 INFO - Usage: mozinstall [options] installer 01:55:17 INFO - Options: 01:55:17 INFO - -h, --help show this help message and exit 01:55:17 INFO - -d DEST, --destination=DEST 01:55:17 INFO - Directory to install application into. [default: 01:55:17 INFO - "/builds/slave/test"] 01:55:17 INFO - --app=APP Application being installed. [default: firefox] 01:55:17 INFO - mkdir: /builds/slave/test/build/application 01:55:17 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'] 01:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:55:33 INFO - Reading from file tmpfile_stdout 01:55:33 INFO - Output received: 01:55:33 INFO - /builds/slave/test/build/application/firefox/firefox 01:55:33 INFO - Running post-action listener: _resource_record_post_action 01:55:33 INFO - [mozharness: 2017-01-10 09:55:33.553120Z] Finished install step (success) 01:55:33 INFO - [mozharness: 2017-01-10 09:55:33.553471Z] Running run-tests step. 01:55:33 INFO - Running pre-action listener: _resource_record_pre_action 01:55:33 INFO - Running main action method: run_tests 01:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:55:33 INFO - Python 2.7.3 01:55:33 INFO - Return code: 0 01:55:33 INFO - grabbing minidump binary from tooltool 01:55:33 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')]} 01:55:33 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 0x11683f0>, '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 0x1168cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11691a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:55:33 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 01:55:33 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 01:55:33 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 01:55:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:55:33 INFO - Return code: 0 01:55:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:55:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:55:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:55:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:55:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:55:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:55:33 INFO - Using env: {'DISPLAY': ':0', 01:55:33 INFO - 'HOME': '/home/cltbld', 01:55:33 INFO - 'LANG': 'en_US.UTF-8', 01:55:33 INFO - 'LANGUAGE': 'en_US:en', 01:55:33 INFO - 'LOGNAME': 'cltbld', 01:55:33 INFO - 'MAIL': '/var/mail/cltbld', 01:55:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:55:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:33 INFO - 'MOZ_NO_REMOTE': '1', 01:55:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:33 INFO - 'NO_EM_RESTART': '1', 01:55:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:33 INFO - 'PWD': '/builds/slave/test', 01:55:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:55:33 INFO - 'SHELL': '/bin/bash', 01:55:33 INFO - 'SHLVL': '1', 01:55:33 INFO - 'TERM': 'linux', 01:55:33 INFO - 'TMOUT': '86400', 01:55:33 INFO - 'USER': 'cltbld', 01:55:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832', 01:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:33 INFO - '_': '/tools/buildbot/bin/python'} 01:55:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:55:33 INFO - mozversion application_buildid: 20170110091743 01:55:33 INFO - mozversion application_changeset: a61edc75cfb522ad1a87bb2be1e1419049361ac4 01:55:33 INFO - mozversion application_display_name: Nightly 01:55:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:55:33 INFO - mozversion application_name: Firefox 01:55:33 INFO - mozversion application_remotingname: firefox 01:55:33 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:55:33 INFO - mozversion application_vendor: Mozilla 01:55:33 INFO - mozversion application_version: 53.0a1 01:55:33 INFO - mozversion platform_buildid: 20170110091743 01:55:33 INFO - mozversion platform_changeset: a61edc75cfb522ad1a87bb2be1e1419049361ac4 01:55:33 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:55:33 INFO - mozversion platform_version: 53.0a1 01:55:33 INFO - using testdate: 1484042133 01:55:33 INFO - actual date: 1484042133 01:55:33 INFO - starting webserver on 'localhost:60044' 01:55:33 INFO - SUITE-START | Running 2 tests 01:55:33 INFO - TEST-START | dromaeo_css 01:55:33 INFO - operating with platform_type : linux_ 01:55:33 INFO - Initialising browser for dromaeo_css test... 01:55:33 INFO - TEST-INFO | started process 10305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJJtfd/profile http://localhost:60044/getInfo.html) 01:55:34 INFO - PROCESS | 10305 | 1484042134329 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 01:55:37 INFO - PROCESS | 10305 | __metrics Screen width/height:1600/1200 01:55:37 INFO - PROCESS | 10305 | colorDepth:24 01:55:37 INFO - PROCESS | 10305 | Browser inner width/height: 1024/697 01:55:37 INFO - PROCESS | 10305 | __metrics 01:55:38 INFO - PROCESS | 10305 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:55:38 INFO - PROCESS | 10305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:55:39 INFO - PROCESS | 10305 | console.error: PushService: 01:55:39 INFO - PROCESS | 10305 | stateChangeProcessEnqueue: Error transitioning state 01:55:39 INFO - PROCESS | 10305 | UnknownError 01:55:40 INFO - TEST-INFO | 10305: exit 0 01:55:40 INFO - Browser initialized. 01:55:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:55:40 INFO - TEST-INFO | started process 10386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGJJtfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:55:52 INFO - PROCESS | 10386 | RSS: Main: 151511040 01:55:52 INFO - PROCESS | 10386 | 01:58:57 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60044/tests/dromaeo/cssquery-ext.html) 01:58:59 INFO - PROCESS | 10386 | RSS: Main: 265973760 01:58:59 INFO - PROCESS | 10386 | 02:00:41 INFO - PROCESS | 10386 | ************************* 02:00:41 INFO - PROCESS | 10386 | A coding exception was thrown and uncaught in a Task. 02:00:41 INFO - PROCESS | 10386 | 02:00:41 INFO - PROCESS | 10386 | Full message: ReferenceError: fetch is not defined 02:00:41 INFO - PROCESS | 10386 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 02:00:41 INFO - PROCESS | 10386 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 02:00:41 INFO - PROCESS | 10386 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 02:00:41 INFO - PROCESS | 10386 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:00:41 INFO - PROCESS | 10386 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:00:41 INFO - PROCESS | 10386 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:00:41 INFO - PROCESS | 10386 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 02:00:41 INFO - PROCESS | 10386 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 02:00:41 INFO - PROCESS | 10386 | TaskImpl@resource://gre/modules/Task.jsm:277:3 02:00:41 INFO - PROCESS | 10386 | asyncFunction@resource://gre/modules/Task.jsm:252:14 02:00:41 INFO - PROCESS | 10386 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 02:00:41 INFO - PROCESS | 10386 | 02:00:41 INFO - PROCESS | 10386 | ************************* 02:02:01 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-ext.html (next: http://localhost:60044/tests/dromaeo/cssquery-jquery.html) 02:02:02 INFO - PROCESS | 10386 | RSS: Main: 238411776 02:02:02 INFO - PROCESS | 10386 | 02:05:04 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60044/tests/dromaeo/cssquery-mootools.html) 02:05:05 INFO - PROCESS | 10386 | RSS: Main: 221184000 02:05:05 INFO - PROCESS | 10386 | 02:08:07 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60044/tests/dromaeo/cssquery-prototype.html) 02:08:08 INFO - PROCESS | 10386 | RSS: Main: 185638912 02:08:08 INFO - PROCESS | 10386 | 02:11:11 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60044/tests/dromaeo/cssquery-yui.html) 02:11:12 INFO - PROCESS | 10386 | RSS: Main: 186482688 02:11:12 INFO - PROCESS | 10386 | 02:14:14 INFO - PROCESS | 10386 | Cycle 1(1): loaded http://localhost:60044/tests/dromaeo/cssquery-yui.html (next: http://localhost:60044/tests/dromaeo/cssquery-dojo.html) 02:14:15 INFO - PROCESS | 10386 | RSS: Main: 275988480 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | __start_tp_report 02:14:15 INFO - PROCESS | 10386 | _x_x_mozilla_page_load 02:14:15 INFO - PROCESS | 10386 | _x_x_mozilla_page_load_details 02:14:15 INFO - PROCESS | 10386 | |i|pagename|runs| 02:14:15 INFO - PROCESS | 10386 | |0;dojo.html;2619.9345016374587;2639.0763232868485;2664.347234927443;2666.373402250471;2668.479646468938;4651.418572678415;4693.342931989524;4727.230986520008;4798.208295631217;4874.512548745124;4763.761811909408;4777.402824646919;4793.6884102533395;4841.806327746895;4923.60611151108;4345.3047512398025;4373.934390984138;4413.051193993291;4462.5537446255275;4537.568930951555;3993.221321842242;4336.739795612273;4458.754768487732;4513.7066090704;4545.999999999984;4292.656587472995;4334.154839806239;4376.89057773555;4383.693141480097;4504.729716217021;4320.4383430153875;4359.324304732771;4389.209942210401;4406.184855801687;4479.059397526524;4347.478302603676;4348.956510434887;4388.934165987513;4403.581659742319;4427.22523558376;4727.66906316558;4756.215224487955;4765.9523404766205;4774.785134668949;4813.422389313269;4972.87567810804;5014.24786282057;5022.221555658879;5025.296458495814;5032.874178145539;5137.357830271216;5143.7685304161405;5143.794248230066;5144.176931690911;5157.045946499909;4804.73573953429;4806.639502037361;4813.542713442217;4822.8794280143275;4835.8065677373215;5134.589232861362;5153.974230128825;5171.4311425743135;5213.139831927765;5320.840374788685;5025.899482010339;5053.317802096743;5056.721880296545;5105.821296254688;5119.129747942859;5017.197248440232;5069.695818250917;5153.724530003898;5154.329937108227;5155;4971.6271279654175;5018.648694591417;5030.270610761492;5083.212102124176;5106.157484015096;4968.478309777422;5024.497550244946;5027.271045698426;5028.522290382408;5070.771815268248;4242.321228603409;4242.406063151161;4307.289297265978;4314.158739045919;4375.803088861009;3755.342815007363;3755.962440375561;3760.962390376061;3795.0512371907025;3799.848006079781;4486.573775491323;4488.102379524108;4488.39406680094;4492.73043617384;4530.433695788027;5026;5069.340985671913;5145.536901678792;5178.585713142939;5185.196294574347;4467.754273514923;4483.50681425043;4484.573965473275;4524.02733412318;4526.049529598821;4591.311303304465;4592.173408786383;4634.050019745944;4637.976810115928;4641.582257596832;4636.489986101458;4685.226937555265;4699.177643912233;4791.305260737104;4819.108464933998;5139.511746384088;5141.100307446257;5145.253938179018;5180.715060671549;5193.870153246199;4766.094442055998;4766.880827979328;4770.928436073392;4778.139934811628;4812.326274321527;4920.40955085392;4947.381577302837;5010.849674509771;5017.698938063728;5065.3161823153405;5082.263071854486;5138.434772174983;5144.279800827812;5170.586353091669;5185.144451165666;4953.578945789648;4997.225430058346;5000.64995450315;5015.1975683890405;5045;4858.732769697701;4877.609791216623;4914.238293064581;4915.926261106158;4965.155923493087;4949.925751113664;4950.480199578992;4959.7272150032095;4988.476209997898;5002.399712034579;5036.967421678474;5041.949580504148;5047.2429135629945;5049.671771334852;5088.338515992898;4810.831620893392;4848.10310092634;4925.261210818263;4928.433230178432;4978.32792572998 02:14:15 INFO - PROCESS | 10386 | |1;ext.html;500.4320096690258;511;522.7125081205337;542.4548328929425;543.893940681567;29183.708162918363;38536.61463385366;40133.59866401335;40230;40241.79879100608;41871.162576748444;42172.78913605428;42196;42204.155916881646;42346.57653423465;7560.546367217957;7578.545287282767;7744.612769361509;7747.109082455505;7752.341051010642;7562.924370756305;9800.852987205197;10077;10082.697519074403;10450.111740502029;10024.548895299693;10103.696889093302;10106.848397274047;10108.595656173744;10109.34289271195;9798.804023919518;9831.213502919749;9839.55721992512;9851.261155413373;9854.359466634682;9876.506174691236;9952.502374881227;9955.25335599833;9961.501924903798;9962.900370996342;38637.61362386368;38967;39004.92935918312;39051.80474097611;39056.414153787715;3705.5923848376656;3798.4302354646748;3803.562590302123;3822.719389004687;3859.0931131184147;29041.41917161666;29046.709532904613;29096.27259318534;29233.415331693246;30522.542161867368;3395.405803984293;3397.8511691584067;3421.196018935573;3458.0490365149535;3460.411730005905;234978;235997;236486.8175659128;236539;237497;51243.23135152976;51692;51840.74079629578;51855.740721296155;51916;55005.72497137569;55101.31638810666;55107.72446137744;55166;55219.171712424344;14567.41730330775;14816.703665926621;14822.703545929022;14824.258787060604;14836.480723174636;10343.172546196287;10644.148468122532;10867.402292873969;11012.063974562252;11205.551777928791;14916.254187290591;15412.46056388021;15509.689806203813;15559.922200388926;15710.371585136467;6144.589752687212;6166.969165154145;6180.412860778219;6318.873622527523;6425.807225783234;824.1675907333636;826.4627991805254;836.3894357119337;857.4726543175902;866.9869951950726;27096.445228728062;27685.307867303076;27811.72188278132;28022.579661305095;28402.431951360857;975.7853272280087;1003.5835128421769;1014.4268488304084;1015.4262841494532;1018.9184865210765;13886.305684715724;14690.41238350454;15081.396744130112;15450.38198472071;15727.213639317988;338894;340179;340861;341995;342251;43019.78490107529;43222.78388608037;43259.351109733376;43303.783481083025;43364.13271734548;1259.962201133949;1280.0911352939331;1293.4632127666912;1296.3388671777273;1300.8373953256032;24199.758002420454;26574.468510630068;28765.849366025963;28838.567421488275;29180.416391672472;41623.58376416197;41976;42063.69044643328;42111.05167647304;42176.57823421727;303927;307510;308615;308677;309177;20821.68767468459;21397.679034814802;22330.441738956655;23192.18827341035;23716.4070898222;32750;33066.00801975944;33270.16824579405;35224.47163292604;37205.81397092997;30369.392612148076;30970;31033.534496983015;31175.532367014966;31969.360612788078;30294.394112117192;30581.694183057883;30789.538156928113;30853.8457307712;31727.68272317247;30758.692413075583;31447.685523145392;31723.20691982719;31779.20551986219;31783.364332713678;26831.86584067067;28212.294692632848;28282.85858570694;28464.715352846208;28548.57177142303;22175;22318.776812232318;22421.32736017922;22441.21455749041;22494.21270255533 02:14:15 INFO - PROCESS | 10386 | |2;jquery.html;352.9205928666052;371.75278439837507;376.6572419098619;378.2265267527905;389.287603685256;13573.321333933302;13629.591112266624;17911.820881791176;17956.37152699654;17960.64078718425;16803.24385402657;17554.648907021885;17702.380416685417;17725.556861078447;17741.822581774177;3882.7476214045996;4891.926621100677;5077.771500282496;5082.618803589727;5087.160618497944;4084.8570300039505;5636.18275350074;5871.1193321001765;5886.381929897363;6019.699015049252;5801.53587712982;5927.851803704899;5992.071228959497;6003;6021.819345419644;5881.117832325185;5922.703864806743;5950.196723442345;5955.940440595582;5965.254343207099;4649.883752906205;4895.804167833282;4943.777530011158;5222.63441559091;5227.843164705065;12128.45421956014;12160.5135794569;12186.939065304705;12322.137450378477;18623.720644190347;2147.688585155159;2154.3321570313096;2161.3083813179787;2204.1073365287084;2205.9669104963436;9500.667476638353;10539.209559283085;12859.35703214845;13068.934655326757;13799;1669.4073603870695;1708.666809972056;1713.1263055841487;1723.1470422140994;1746.0745804723517;64777;76624;78858;80634.59682701608;82200.17799821925;8522.446041007439;9001.63993440255;9077.228435582918;9982.058880854023;10131.189504839742;11979.820302695467;12050.939745301217;12137.089718270989;12186;12218.144729868824;5632.2678051853;5682.7442765075675;5780.32370612526;6101.60339577926;7344.669489872968;7105.680244389015;7142.464315176382;7152.499325047301;7248.528845625017;7369.336759691653;3751.9249615008093;3784.5647750509042;3827.942580861289;3845.538535375717;3865.903352416212;1670.2650833633163;1724.3016578285815;1726.5769886377918;1740.7562941188244;1768.5490199998917;841.4488510025943;846.530175752451;852.3692467573951;861.4314552395389;884.4295429448099;16835.83164168367;16932.32270709158;17059.744103838453;17276.654466910844;17806.91096544509;792.6274650914061;818.2145140664909;826.4751882554621;830.4436027861348;848.321342925657;5544.722763861791;5581.265319774539;5744.834994628861;5845.357010728816;5872.471477567039;572176.3650089706;573533;575816;588968;591174;93860;95009.52495237617;95578;95830.52084739531;96880;1016.4663551635302;1035.9223058270509;1057.8677665291993;1067.8451624514403;1071.2233630617895;9459.952700236454;9484.478353690338;9549.809003820024;9558.713238602853;9986.151177150025;37050.814745926094;39053.41419878647;39280.410793837545;39602.60397396104;40427.39358909678;56528.43471565396;56611.43388566062;57656.42343576511;57886.4211357881;58151;7666.4633475656165;7759.340456061298;7804.687812487664;7857.371410287049;7988.3609311253795;11337.659870203906;11377.658670239905;11901.464434100313;12056.156069075081;12977.026722996003;9572;9625.181859541737;9698.321117521988;10085.949570252102;10326.896731032593;10400.843987340044;10575.576976921146;10667.786644266916;10980.560777569128;11122.606570404807;10112.79774404493;10145.746356341151;10206.183505319705;10375.429351385445;10518.158547316349;7802.843943121219;7832.569208693349;7901.407394445325;7992.121851365041;8017.559034253172;9527.38072025316;9934.801303973736;10090.54592543352;10192.898071019195;10416.375017498975 02:14:15 INFO - PROCESS | 10386 | |3;mootools.html;1341.1014620204462;1345.703945132071;1349.6153596225079;1353.3706826325752;1360.3062438156537;6856.862862742742;7188.71245150194;7234.96382518088;7242.710291588343;7282.890756638648;6427.903581446282;6547.57440766351;6819.693113809878;6947.8957815632675;7013.964930175354;2081.375587323804;2092.79072092791;2098.8771007510986;2100.663893776996;2104.6632538793797;2040.8877511736848;2100.1389430333566;2109.493721506835;2110.841686873483;2114.767375588684;1813.8820976636543;1885.962280754384;1888.5278680329918;1901.505608541782;1902.3436914264557;2027.2195204846093;2082.3648787119996;2096.4758810297426;2118.894055297229;2119.73503312086;2052.8049835265774;2057.0537552725614;2075.086961736846;2075.3462659262286;2079.324219628627;7068.823279418056;7093;7123.074000379969;7190.137183537957;7280.708771649128;4261.914761704748;4286.485621725413;4310.4611923509565;4327.848525301631;4342.696011279212;2617.149426436397;2685.261553072901;2729.672439307276;2743.3827388837353;2821.619081424002;974.668612671695;1006.0381674210369;1041.5937784264142;1055.4933631856675;1060.241927022175;9289.767755806091;9408.482533460658;9417.76455588609;9424.34029617927;9464.858027129598;3785.4511095891494;3970.285348637273;4020.216057868746;4056.452378928866;4057.634812866797;8092.635831387602;8156.469829461066;8161.428699991063;8239.95880020596;8256.215659512336;4520.773961301988;4544.068465964469;4586.518415566317;4599.08018396322;4601.953980460219;4038.8586399475876;4104.97375656086;4204.138151678899;4208.9789551052045;4209.989602495379;3249.6750324967315;3268.460703983816;3330.816805075696;3341.465365541502;3366.9494957575657;1073.0700126068361;1093.9288946218471;1098.9010989010867;1101.3777215873006;1103.172620534599;581.9225365445319;642.2453617000007;830.4477522447505;854.9478362246844;882.7219425880827;4754.096721622881;4773;4784.497627749106;4826.806927722922;4872;899.5637115998735;913.55235934393;921.1801496667971;936.5176933879058;951.9286053546011;3306.7685262031428;3498.440249560058;3501.439769636897;3509.105178179599;3548.6273941236313;8226;8589.012263589642;8637.222649961534;8656.95671521651;8684.131586841266;8521.062683104854;8537.103604121601;8586.39895207342;8608.268297194809;8633.39566230358;6797.320267973163;6821.317868213139;6839.521233513706;6840.692168852314;6841.452683785385;4789.712617242976;4891.241857512091;4933.925991110064;5044.293798868088;5054.9494505055945;7496.550206987598;7840.411969102226;7862.60686965638;7905.051393832777;7942.007249093864;7713.2286771322415;7812.101608315116;7855.5286682799215;7926.762197134095;7940.28537431634;6348.77779277723;6392.328805475358;6401.231852177769;6403.167588213502;6405.423511883952;6814.93185068143;6841.144856892888;6854.246032936273;6870.519063665495;6913.343232392915;6164.270780837556;6175.629462232101;6214.440700336811;6235.688215589112;6280.937190628035;6033.849153771015;6172.043333283348;6179.783707570214;6192.3807619239515;6201.286852012076;5385.3268341457315;5527.2538207341495;5553.500184983371;5760.107183386582;5800.50695690871;4081.6734661227624;4110.159409945272;4123.97938010308;4153.667706583406;4173.123644034787;4322.416473776;4382.101669157879;4437.3343998399205;4457.242268814244;4524.072565124207 02:14:15 INFO - PROCESS | 10386 | |4;prototype.html;347.58116469654067;348.79944032181504;350.91928856363035;356.5863598226057;361.33514333626124;4841.273808928658;4876.268559716044;4893.755312234387;4894.339264199332;4904.583110435608;4808.3989501312335;4815.494373090827;4825.638077144211;4829.179039563274;4835.549335199435;3412.7952322860583;3685.815709214542;3755.6619904208615;3844.5386553613607;3901.0637447012728;3815.5993620669847;3821.9808900955454;3830.655241028307;3831.4061320495366;3839.9424008639894;3828.731988760774;3839.731218814684;3842.769433833979;3850.6919446444217;3854.3640299350573;3687.50218720472;3747.4378843173467;3803.6006219346846;3859.536855577335;3865.690744740414;3448.6034106077873;3464.4803279508023;3472.947905781415;3473.235888104613;3475.2701932594186;4707.976460117678;4724.984128412373;4726.598239149642;4731.952680473186;4753.524647535253;4321.114171594815;4409.250427427345;4421.447319085114;4430.734155950621;4432.711873728197;5044.419891712463;5063.620228482841;5069.188929771219;5082.288479612857;5083.262926875619;3798.9810050949845;3818.198178382543;3824.0822202671156;3830.616938306175;3837.808109594537;5097.49025097491;5261.789528418897;5365.946340536622;5369.147644062792;5383.488568585978;3797.3354662933875;3872.8838134856;3888.766673999569;3889.871937138198;3896.123372241223;3912.9021774455296;3946.960530394717;3963.2667956428154;3971;3990.7206495545615;4420;4421.955780442218;4424.911501769947;4470.619997300201;4471.35165401015;4925.556699897026;5071.949280507221;5072.543471087546;5086.109930762102;5086.567641750493;1331.181323486049;1350.1156742333787;1353.3827076643317;1355.8915286777035;1361.3125371687236;930.567587824748;967.5742673223759;973.9481360131041;978.6232300564334;979.275336251169;4328.653707703376;4332.916770807298;4336.891577710582;4339.804708788112;4367.192069467159;5055.797768089235;5059.2916991621205;5067.797288108434;5081.364829396325;5103.826119992423;4241.703080784378;4322.827086916551;4347.413099231563;4356;4368.847090351823;2682.181934509993;2691.838489690625;2707.3502359433987;2717.972820271772;2722.4555088982283;4760.642951778561;4790.640701947368;4792.161371759928;4806.206975849016;4808.927866082012;5033.3205017322925;5194.896102077937;5214.348206474191;5230.8169214077325;5236.941370437941;4914.287428322873;4930.531599498042;4936.605071594264;4938.9012219755405;4939.3084968104495;5219.76511057011;5243.397009343974;5244.737763111905;5247;5257.526822585985;4927.852164435073;5118;5144.9742751286;5159.767810448464;5160.535551800356;4690.200937240846;4749.857504274739;4809.759512024315;4896.485868983706;4917.237828136645;3673.651003154696;3680.8159592019756;3683.9263214736093;3687.6681098701247;3710.443433484891;5238.292830467838;5285.260063591178;5285.286486324297;5287.68273903567;5290.550303224269;4963.503649635008;5065.316182315488;5070.847874563769;5101.617378696538;5104.9744751276;5063.556886287391;5078.597339782428;5080.161773307363;5084.161113416245;5101;5008.474110218374;5018.473060328759;5025.6482046256415;5041.445441001413;5046.1673823818655;5002.620467333063;5004.047611908991;5088.338515992898;5092.923606145985;5111.821086261963;4956.628252880976;4958.058343616761;4986.401631804061;4986.551210391082;4988.351514303117 02:14:15 INFO - PROCESS | 10386 | |5;yui.html;633.5058654249686;663.7444583835226;723.2694978072145;760.3612965109307;776.4797585617638;12324.63026109217;12970.74058518829;12991.285479298635;13013.804792928102;13014.284214368217;13218.801717974238;13450.1257418268;13456.125351852123;13463.394147263372;13474.865251347484;658.8879890418616;674.9730010799562;791.683326669334;796.9880451793227;806.6370133439946;804.3283857978565;818.4557269415832;819.5205804604313;819.737683941139;819.8483280593109;876.4565969099167;876.776422012386;877.8024944387525;877.863931090682;877.9604917778715;689.1007235557595;703.2299631903059;840.4117118017413;874.4665753890154;874.637025634361;627.3068259573151;630.6058713304185;630.6562923206864;631.0534198701947;631.3244828034005;13437.66405839852;13458.798118028237;13468;13472.326383680776;13477.393517291745;12745.745085098339;12789.808152877715;12828.999999999907;12945.87054129456;12999.1550549214;11343.829842552368;11530.827037594443;11540;11739.530418783239;11847.881521184763;4034.616711412411;4170.270202714512;4250.298700714378;4261.21167583998;4276.679249056333;62445.37554624487;63921.360786392004;64017;64135;65261.67369163124;10324.535395907202;10325.277230593936;10460.581576736997;10480.371177729361;10681.46592670379;19682.70475942862;19690.507737306394;19705.11326990289;19713.704294435596;19717;6539.149910511603;6593.7362505500205;6612.7354905804195;6745.258021617618;6872.896906546406;3546.911327216789;3560.2701446203464;3590.2281009583066;3593.8742144025355;3641.435577485441;2747.738964798341;2792.4135931454216;2815.366542527915;2825.477286701967;2827.7275226148317;484.6776893365872;492.12156301003256;499.34835040272793;505.11856809867015;506.26844210116764;525.5401523666792;531.325216974448;535.154455959583;605.3492495567283;643.9323870993572;8647.351448641377;8979.955100224457;9004.36969412148;9140.90859091414;9317.813643727088;503.8916632923939;519.3300642171556;519.3326575350657;558.0178885162144;621.7077973352517;4181.456410666655;4327.480702315679;4373;4388.4733831940375;4438.4451943507065;62418.0637290441;62434.37565624285;63094.684526577075;66330;66484;54998.17502737462;55987.16019259714;57033.42966570281;57587.42412575905;58025.70987145122;39053.02367440837;40707.185856282114;42023.7898810504;42559.787201063795;49668.75165624149;9459.858102128335;10045.899541004497;10091.79816403653;10162.542685579314;10167.237457190593;32601.18497037593;32695.18262043468;33479.83260083684;33577.2991781146;34006;39957.20085598213;40144.59855401408;40607.3908891361;40774.18451630892;40911.590884091966;11010.119190464904;11130.276532025393;11220.887791122312;11241.213115082193;11382.430878456209;12528.248305101723;12594.27560045532;12826.166299190523;13312.534061307808;13360.532381366605;11904.464299106388;12304.446299916346;12628.431720572413;13016;13033.543825966424;12148;12549.623511294676;12859.742805143658;13041.217526948414;13320.93339533296;11510.44220264349;11992.820107698217;12032.699182520508;12146;12232.87767122353;10376.27366084397;10645.361278323326;10650.147988160774;10664.200184986312;10691.625793097204;8759.299256059627;9593.232541396812;10114.140298074451;10114.190864730952;10135.290529663147 02:14:15 INFO - PROCESS | 10386 | __end_tp_report 02:14:15 INFO - PROCESS | 10386 | __start_cc_report 02:14:15 INFO - PROCESS | 10386 | _x_x_mozilla_cycle_collect,1233 02:14:15 INFO - PROCESS | 10386 | __end_cc_report 02:14:15 INFO - PROCESS | 10386 | __startTimestamp1484043255230__endTimestamp 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | ------- Summary: start ------- 02:14:15 INFO - PROCESS | 10386 | Number of tests: 6 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#0] dojo.html Cycles:165 Average:4721.07 Median:4835.81 stddev:494.93 (10.2%) stddev-sans-first:468.19 02:14:15 INFO - PROCESS | 10386 | Values: 2619.9 2639.1 2664.3 2666.4 2668.5 4651.4 4693.3 4727.2 4798.2 4874.5 4763.8 4777.4 4793.7 4841.8 4923.6 4345.3 4373.9 4413.1 4462.6 4537.6 3993.2 4336.7 4458.8 4513.7 4546.0 4292.7 4334.2 4376.9 4383.7 4504.7 4320.4 4359.3 4389.2 4406.2 4479.1 4347.5 4349.0 4388.9 4403.6 4427.2 4727.7 4756.2 4766.0 4774.8 4813.4 4972.9 5014.2 5022.2 5025.3 5032.9 5137.4 5143.8 5143.8 5144.2 5157.0 4804.7 4806.6 4813.5 4822.9 4835.8 5134.6 5154.0 5171.4 5213.1 5320.8 5025.9 5053.3 5056.7 5105.8 5119.1 5017.2 5069.7 5153.7 5154.3 5155.0 4971.6 5018.6 5030.3 5083.2 5106.2 4968.5 5024.5 5027.3 5028.5 5070.8 4242.3 4242.4 4307.3 4314.2 4375.8 3755.3 3756.0 3761.0 3795.1 3799.8 4486.6 4488.1 4488.4 4492.7 4530.4 5026.0 5069.3 5145.5 5178.6 5185.2 4467.8 4483.5 4484.6 4524.0 4526.0 4591.3 4592.2 4634.1 4638.0 4641.6 4636.5 4685.2 4699.2 4791.3 4819.1 5139.5 5141.1 5145.3 5180.7 5193.9 4766.1 4766.9 4770.9 4778.1 4812.3 4920.4 4947.4 5010.8 5017.7 5065.3 5082.3 5138.4 5144.3 5170.6 5185.1 4953.6 4997.2 5000.6 5015.2 5045.0 4858.7 4877.6 4914.2 4915.9 4965.2 4949.9 4950.5 4959.7 4988.5 5002.4 5037.0 5041.9 5047.2 5049.7 5088.3 4810.8 4848.1 4925.3 4928.4 4978.3 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#1] ext.html Cycles:180 Average:44471.42 Median:31781.28 stddev:78229.12 (246.1%) stddev-sans-first:78378.91 02:14:15 INFO - PROCESS | 10386 | Values: 500.4 511.0 522.7 542.5 543.9 29183.7 38536.6 40133.6 40230.0 40241.8 41871.2 42172.8 42196.0 42204.2 42346.6 7560.5 7578.5 7744.6 7747.1 7752.3 7562.9 9800.9 10077.0 10082.7 10450.1 10024.5 10103.7 10106.8 10108.6 10109.3 9798.8 9831.2 9839.6 9851.3 9854.4 9876.5 9952.5 9955.3 9961.5 9962.9 38637.6 38967.0 39004.9 39051.8 39056.4 3705.6 3798.4 3803.6 3822.7 3859.1 29041.4 29046.7 29096.3 29233.4 30522.5 3395.4 3397.9 3421.2 3458.0 3460.4 234978.0 235997.0 236486.8 236539.0 237497.0 51243.2 51692.0 51840.7 51855.7 51916.0 55005.7 55101.3 55107.7 55166.0 55219.2 14567.4 14816.7 14822.7 14824.3 14836.5 10343.2 10644.1 10867.4 11012.1 11205.6 14916.3 15412.5 15509.7 15559.9 15710.4 6144.6 6167.0 6180.4 6318.9 6425.8 824.2 826.5 836.4 857.5 867.0 27096.4 27685.3 27811.7 28022.6 28402.4 975.8 1003.6 1014.4 1015.4 1018.9 13886.3 14690.4 15081.4 15450.4 15727.2 338894.0 340179.0 340861.0 341995.0 342251.0 43019.8 43222.8 43259.4 43303.8 43364.1 1260.0 1280.1 1293.5 1296.3 1300.8 24199.8 26574.5 28765.8 28838.6 29180.4 41623.6 41976.0 42063.7 42111.1 42176.6 303927.0 307510.0 308615.0 308677.0 309177.0 20821.7 21397.7 22330.4 23192.2 23716.4 32750.0 33066.0 33270.2 35224.5 37205.8 30369.4 30970.0 31033.5 31175.5 31969.4 30294.4 30581.7 30789.5 30853.8 31727.7 30758.7 31447.7 31723.2 31779.2 31783.4 26831.9 28212.3 28282.9 28464.7 28548.6 22175.0 22318.8 22421.3 22441.2 22494.2 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#2] jquery.html Cycles:180 Average:30098.29 Median:5010.77 stddev:95512.70 (1906.1%) stddev-sans-first:95754.52 02:14:15 INFO - PROCESS | 10386 | Values: 352.9 371.8 376.7 378.2 389.3 13573.3 13629.6 17911.8 17956.4 17960.6 16803.2 17554.6 17702.4 17725.6 17741.8 3882.7 4891.9 5077.8 5082.6 5087.2 4084.9 5636.2 5871.1 5886.4 6019.7 5801.5 5927.9 5992.1 6003.0 6021.8 5881.1 5922.7 5950.2 5955.9 5965.3 4649.9 4895.8 4943.8 5222.6 5227.8 12128.5 12160.5 12186.9 12322.1 18623.7 2147.7 2154.3 2161.3 2204.1 2206.0 9500.7 10539.2 12859.4 13068.9 13799.0 1669.4 1708.7 1713.1 1723.1 1746.1 64777.0 76624.0 78858.0 80634.6 82200.2 8522.4 9001.6 9077.2 9982.1 10131.2 11979.8 12050.9 12137.1 12186.0 12218.1 5632.3 5682.7 5780.3 6101.6 7344.7 7105.7 7142.5 7152.5 7248.5 7369.3 3751.9 3784.6 3827.9 3845.5 3865.9 1670.3 1724.3 1726.6 1740.8 1768.5 841.4 846.5 852.4 861.4 884.4 16835.8 16932.3 17059.7 17276.7 17806.9 792.6 818.2 826.5 830.4 848.3 5544.7 5581.3 5744.8 5845.4 5872.5 572176.4 573533.0 575816.0 588968.0 591174.0 93860.0 95009.5 95578.0 95830.5 96880.0 1016.5 1035.9 1057.9 1067.8 1071.2 9460.0 9484.5 9549.8 9558.7 9986.2 37050.8 39053.4 39280.4 39602.6 40427.4 56528.4 56611.4 57656.4 57886.4 58151.0 7666.5 7759.3 7804.7 7857.4 7988.4 11337.7 11377.7 11901.5 12056.2 12977.0 9572.0 9625.2 9698.3 10085.9 10326.9 10400.8 10575.6 10667.8 10980.6 11122.6 10112.8 10145.7 10206.2 10375.4 10518.2 7802.8 7832.6 7901.4 7992.1 8017.6 9527.4 9934.8 10090.5 10192.9 10416.4 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#3] mootools.html Cycles:180 Average:4713.44 Median:4912.58 stddev:2529.83 (51.5%) stddev-sans-first:2524.23 02:14:15 INFO - PROCESS | 10386 | Values: 1341.1 1345.7 1349.6 1353.4 1360.3 6856.9 7188.7 7235.0 7242.7 7282.9 6427.9 6547.6 6819.7 6947.9 7014.0 2081.4 2092.8 2098.9 2100.7 2104.7 2040.9 2100.1 2109.5 2110.8 2114.8 1813.9 1886.0 1888.5 1901.5 1902.3 2027.2 2082.4 2096.5 2118.9 2119.7 2052.8 2057.1 2075.1 2075.3 2079.3 7068.8 7093.0 7123.1 7190.1 7280.7 4261.9 4286.5 4310.5 4327.8 4342.7 2617.1 2685.3 2729.7 2743.4 2821.6 974.7 1006.0 1041.6 1055.5 1060.2 9289.8 9408.5 9417.8 9424.3 9464.9 3785.5 3970.3 4020.2 4056.5 4057.6 8092.6 8156.5 8161.4 8240.0 8256.2 4520.8 4544.1 4586.5 4599.1 4602.0 4038.9 4105.0 4204.1 4209.0 4210.0 3249.7 3268.5 3330.8 3341.5 3366.9 1073.1 1093.9 1098.9 1101.4 1103.2 581.9 642.2 830.4 854.9 882.7 4754.1 4773.0 4784.5 4826.8 4872.0 899.6 913.6 921.2 936.5 951.9 3306.8 3498.4 3501.4 3509.1 3548.6 8226.0 8589.0 8637.2 8657.0 8684.1 8521.1 8537.1 8586.4 8608.3 8633.4 6797.3 6821.3 6839.5 6840.7 6841.5 4789.7 4891.2 4933.9 5044.3 5054.9 7496.6 7840.4 7862.6 7905.1 7942.0 7713.2 7812.1 7855.5 7926.8 7940.3 6348.8 6392.3 6401.2 6403.2 6405.4 6814.9 6841.1 6854.2 6870.5 6913.3 6164.3 6175.6 6214.4 6235.7 6280.9 6033.8 6172.0 6179.8 6192.4 6201.3 5385.3 5527.3 5553.5 5760.1 5800.5 4081.7 4110.2 4124.0 4153.7 4173.1 4322.4 4382.1 4437.3 4457.2 4524.1 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#4] prototype.html Cycles:180 Average:4231.66 Median:4807.30 stddev:1193.29 (24.8%) stddev-sans-first:1160.48 02:14:15 INFO - PROCESS | 10386 | Values: 347.6 348.8 350.9 356.6 361.3 4841.3 4876.3 4893.8 4894.3 4904.6 4808.4 4815.5 4825.6 4829.2 4835.5 3412.8 3685.8 3755.7 3844.5 3901.1 3815.6 3822.0 3830.7 3831.4 3839.9 3828.7 3839.7 3842.8 3850.7 3854.4 3687.5 3747.4 3803.6 3859.5 3865.7 3448.6 3464.5 3472.9 3473.2 3475.3 4708.0 4725.0 4726.6 4732.0 4753.5 4321.1 4409.3 4421.4 4430.7 4432.7 5044.4 5063.6 5069.2 5082.3 5083.3 3799.0 3818.2 3824.1 3830.6 3837.8 5097.5 5261.8 5365.9 5369.1 5383.5 3797.3 3872.9 3888.8 3889.9 3896.1 3912.9 3947.0 3963.3 3971.0 3990.7 4420.0 4422.0 4424.9 4470.6 4471.4 4925.6 5071.9 5072.5 5086.1 5086.6 1331.2 1350.1 1353.4 1355.9 1361.3 930.6 967.6 973.9 978.6 979.3 4328.7 4332.9 4336.9 4339.8 4367.2 5055.8 5059.3 5067.8 5081.4 5103.8 4241.7 4322.8 4347.4 4356.0 4368.8 2682.2 2691.8 2707.4 2718.0 2722.5 4760.6 4790.6 4792.2 4806.2 4808.9 5033.3 5194.9 5214.3 5230.8 5236.9 4914.3 4930.5 4936.6 4938.9 4939.3 5219.8 5243.4 5244.7 5247.0 5257.5 4927.9 5118.0 5145.0 5159.8 5160.5 4690.2 4749.9 4809.8 4896.5 4917.2 3673.7 3680.8 3683.9 3687.7 3710.4 5238.3 5285.3 5285.3 5287.7 5290.6 4963.5 5065.3 5070.8 5101.6 5105.0 5063.6 5078.6 5080.2 5084.2 5101.0 5008.5 5018.5 5025.6 5041.4 5046.2 5002.6 5004.0 5088.3 5092.9 5111.8 4956.6 4958.1 4986.4 4986.6 4988.4 02:14:15 INFO - PROCESS | 10386 | 02:14:15 INFO - PROCESS | 10386 | [#5] yui.html Cycles:180 Average:14565.34 Median:22321.00 stddev:17497.46 (78.4%) stddev-sans-first:17515.27 02:14:15 INFO - PROCESS | 10386 | Values: 633.5 663.7 723.3 760.4 776.5 12324.6 12970.7 12991.3 13013.8 13014.3 13218.8 13450.1 13456.1 13463.4 13474.9 658.9 675.0 791.7 797.0 806.6 804.3 818.5 819.5 819.7 819.8 876.5 876.8 877.8 877.9 878.0 689.1 703.2 840.4 874.5 874.6 627.3 630.6 630.7 631.1 631.3 13437.7 13458.8 13468.0 13472.3 13477.4 12745.7 12789.8 12829.0 12945.9 12999.2 11343.8 11530.8 11540.0 11739.5 11847.9 4034.6 4170.3 4250.3 4261.2 4276.7 62445.4 63921.4 64017.0 64135.0 65261.7 10324.5 10325.3 10460.6 10480.4 10681.5 19682.7 19690.5 19705.1 19713.7 19717.0 6539.1 6593.7 6612.7 6745.3 6872.9 3546.9 3560.3 3590.2 3593.9 3641.4 2747.7 2792.4 2815.4 2825.5 2827.7 484.7 492.1 499.3 505.1 506.3 525.5 531.3 535.2 605.3 643.9 8647.4 8980.0 9004.4 9140.9 9317.8 503.9 519.3 519.3 558.0 621.7 4181.5 4327.5 4373.0 4388.5 4438.4 62418.1 62434.4 63094.7 66330.0 66484.0 54998.2 55987.2 57033.4 57587.4 58025.7 39053.0 40707.2 42023.8 42559.8 49668.8 9459.9 10045.9 10091.8 10162.5 10167.2 32601.2 32695.2 33479.8 33577.3 34006.0 39957.2 40144.6 40607.4 40774.2 40911.6 11010.1 11130.3 11220.9 11241.2 11382.4 12528.2 12594.3 12826.2 13312.5 13360.5 11904.5 12304.4 12628.4 13016.0 13033.5 12148.0 12549.6 12859.7 13041.2 13320.9 11510.4 11992.8 12032.7 12146.0 12232.9 10376.3 10645.4 10650.1 10664.2 10691.6 8759.3 9593.2 10114.1 10114.2 10135.3 02:14:15 INFO - PROCESS | 10386 | -------- Summary: end -------- 02:14:15 INFO - PROCESS | 10386 | 02:14:16 INFO - TEST-INFO | 10386: exit 0 02:14:16 INFO - TEST-OK | dromaeo_css | took 1122331ms 02:14:16 INFO - TEST-START | kraken 02:14:16 INFO - operating with platform_type : linux_ 02:14:16 INFO - Initialising browser for kraken test... 02:14:16 INFO - TEST-INFO | started process 10683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LaxXZ/profile http://localhost:60044/getInfo.html) 02:14:16 INFO - PROCESS | 10683 | 1484043256646 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 02:14:20 INFO - PROCESS | 10683 | __metrics Screen width/height:1600/1200 02:14:20 INFO - PROCESS | 10683 | colorDepth:24 02:14:20 INFO - PROCESS | 10683 | Browser inner width/height: 1024/697 02:14:20 INFO - PROCESS | 10683 | __metrics 02:14:20 INFO - PROCESS | 10683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:14:20 INFO - PROCESS | 10683 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:21 INFO - PROCESS | 10683 | console.error: PushService: 02:14:21 INFO - PROCESS | 10683 | stateChangeProcessEnqueue: Error transitioning state 02:14:21 INFO - PROCESS | 10683 | UnknownError 02:14:22 INFO - TEST-INFO | 10683: exit 0 02:14:22 INFO - Browser initialized. 02:14:22 INFO - Running cycle 1/1 for kraken test... 02:14:22 INFO - TEST-INFO | started process 10767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0LaxXZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:34 INFO - PROCESS | 10767 | RSS: Main: 152088576 02:14:34 INFO - PROCESS | 10767 | 02:14:36 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60044/tests/kraken/driver.html?testName=audio-beat-detection) 02:14:37 INFO - PROCESS | 10767 | RSS: Main: 206503936 02:14:37 INFO - PROCESS | 10767 | 02:14:40 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60044/tests/kraken/driver.html?testName=audio-dft) 02:14:41 INFO - PROCESS | 10767 | RSS: Main: 186617856 02:14:41 INFO - PROCESS | 10767 | 02:14:44 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60044/tests/kraken/driver.html?testName=audio-fft) 02:14:44 INFO - PROCESS | 10767 | RSS: Main: 268828672 02:14:44 INFO - PROCESS | 10767 | 02:14:47 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60044/tests/kraken/driver.html?testName=audio-oscillator) 02:14:47 INFO - PROCESS | 10767 | RSS: Main: 179597312 02:14:47 INFO - PROCESS | 10767 | 02:14:49 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:14:50 INFO - PROCESS | 10767 | RSS: Main: 182501376 02:14:50 INFO - PROCESS | 10767 | 02:14:53 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60044/tests/kraken/driver.html?testName=imaging-darkroom) 02:14:54 INFO - PROCESS | 10767 | RSS: Main: 222162944 02:14:54 INFO - PROCESS | 10767 | 02:14:57 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60044/tests/kraken/driver.html?testName=imaging-desaturate) 02:14:58 INFO - PROCESS | 10767 | RSS: Main: 222257152 02:14:58 INFO - PROCESS | 10767 | 02:15:01 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60044/tests/kraken/driver.html?testName=json-parse-financial) 02:15:01 INFO - PROCESS | 10767 | RSS: Main: 220102656 02:15:01 INFO - PROCESS | 10767 | 02:15:03 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:04 INFO - PROCESS | 10767 | RSS: Main: 183140352 02:15:04 INFO - PROCESS | 10767 | 02:15:05 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:06 INFO - PROCESS | 10767 | RSS: Main: 190349312 02:15:06 INFO - PROCESS | 10767 | 02:15:08 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:09 INFO - PROCESS | 10767 | RSS: Main: 198492160 02:15:09 INFO - PROCESS | 10767 | 02:15:12 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:12 INFO - PROCESS | 10767 | RSS: Main: 208097280 02:15:12 INFO - PROCESS | 10767 | 02:15:16 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:16 INFO - PROCESS | 10767 | RSS: Main: 204726272 02:15:16 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | Cycle 1(1): loaded http://localhost:60044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60044/tests/kraken/driver.html?testName=ai-astar) 02:15:18 INFO - PROCESS | 10767 | RSS: Main: 256471040 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | __start_tp_report 02:15:18 INFO - PROCESS | 10767 | _x_x_mozilla_page_load 02:15:18 INFO - PROCESS | 10767 | _x_x_mozilla_page_load_details 02:15:18 INFO - PROCESS | 10767 | |i|pagename|runs| 02:15:18 INFO - PROCESS | 10767 | |0;ai-astar;112;113;116;114;114;114;113;112;116;112 02:15:18 INFO - PROCESS | 10767 | |1;audio-beat-detection;148;130;125;153;129;123;128;130;158;125 02:15:18 INFO - PROCESS | 10767 | |2;audio-dft;161;161;159;161;161;163;163;160;160;161 02:15:18 INFO - PROCESS | 10767 | |3;audio-fft;76;77;77;105;78;78;78;78;93;76 02:15:18 INFO - PROCESS | 10767 | |4;audio-oscillator;85;84;109;85;86;84;97;85;85;102 02:15:18 INFO - PROCESS | 10767 | |5;imaging-gaussian-blur;117;116;117;117;117;118;117;118;118;118 02:15:18 INFO - PROCESS | 10767 | |6;imaging-darkroom;149;150;150;150;149;149;149;149;148;149 02:15:18 INFO - PROCESS | 10767 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 02:15:18 INFO - PROCESS | 10767 | |8;json-parse-financial;60;59;59;59;60;61;61;59;60;59 02:15:18 INFO - PROCESS | 10767 | |9;json-stringify-tinderbox;67;68;67;67;67;67;68;68;68;67 02:15:18 INFO - PROCESS | 10767 | |10;stanford-crypto-aes;98;87;96;90;84;95;89;84;86;85 02:15:18 INFO - PROCESS | 10767 | |11;stanford-crypto-ccm;145;144;148;134;132;133;140;133;179;153 02:15:18 INFO - PROCESS | 10767 | |12;stanford-crypto-pbkdf2;179;179;175;181;179;177;181;181;177;179 02:15:18 INFO - PROCESS | 10767 | |13;stanford-crypto-sha256-iterative;67;68;68;68;71;67;68;68;68;71 02:15:18 INFO - PROCESS | 10767 | __end_tp_report 02:15:18 INFO - PROCESS | 10767 | __start_cc_report 02:15:18 INFO - PROCESS | 10767 | _x_x_mozilla_cycle_collect,1850 02:15:18 INFO - PROCESS | 10767 | __end_cc_report 02:15:18 INFO - PROCESS | 10767 | __startTimestamp1484043318635__endTimestamp 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | ------- Summary: start ------- 02:15:18 INFO - PROCESS | 10767 | Number of tests: 14 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:1.48 02:15:18 INFO - PROCESS | 10767 | Values: 112.0 113.0 116.0 114.0 114.0 114.0 113.0 112.0 116.0 112.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:130.00 stddev:12.91 (9.9%) stddev-sans-first:12.80 02:15:18 INFO - PROCESS | 10767 | Values: 148.0 130.0 125.0 153.0 129.0 123.0 128.0 130.0 158.0 125.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 02:15:18 INFO - PROCESS | 10767 | Values: 161.0 161.0 159.0 161.0 161.0 163.0 163.0 160.0 160.0 161.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#3] audio-fft Cycles:10 Average:81.60 Median:78.00 stddev:9.63 (12.3%) stddev-sans-first:10.00 02:15:18 INFO - PROCESS | 10767 | Values: 76.0 77.0 77.0 105.0 78.0 78.0 78.0 78.0 93.0 76.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:85.00 stddev:9.08 (10.7%) stddev-sans-first:9.43 02:15:18 INFO - PROCESS | 10767 | Values: 85.0 84.0 109.0 85.0 86.0 84.0 97.0 85.0 85.0 102.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:15:18 INFO - PROCESS | 10767 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 02:15:18 INFO - PROCESS | 10767 | Values: 149.0 150.0 150.0 150.0 149.0 149.0 149.0 149.0 148.0 149.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:15:18 INFO - PROCESS | 10767 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 02:15:18 INFO - PROCESS | 10767 | Values: 60.0 59.0 59.0 59.0 60.0 61.0 61.0 59.0 60.0 59.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:15:18 INFO - PROCESS | 10767 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.50 stddev:5.21 (5.8%) stddev-sans-first:4.50 02:15:18 INFO - PROCESS | 10767 | Values: 98.0 87.0 96.0 90.0 84.0 95.0 89.0 84.0 86.0 85.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:144.50 stddev:14.24 (9.9%) stddev-sans-first:15.10 02:15:18 INFO - PROCESS | 10767 | Values: 145.0 144.0 148.0 134.0 132.0 133.0 140.0 133.0 179.0 153.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.00 stddev:1.99 (1.1%) stddev-sans-first:2.11 02:15:18 INFO - PROCESS | 10767 | Values: 179.0 179.0 175.0 181.0 179.0 177.0 181.0 181.0 177.0 179.0 02:15:18 INFO - PROCESS | 10767 | 02:15:18 INFO - PROCESS | 10767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 02:15:18 INFO - PROCESS | 10767 | Values: 67.0 68.0 68.0 68.0 71.0 67.0 68.0 68.0 68.0 71.0 02:15:18 INFO - PROCESS | 10767 | -------- Summary: end -------- 02:15:18 INFO - PROCESS | 10767 | 02:15:19 INFO - TEST-INFO | 10767: exit 0 02:15:19 INFO - TEST-OK | kraken | took 63646ms 02:15:19 INFO - SUITE-END | took 1185s 02:15:20 INFO - Completed test suite (00:19:46) 02:15:20 INFO - javascript benchmark 02:15:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.9345016374587, 2639.0763232868485, 2664.347234927443, 2666.373402250471, 2668.479646468938, 4651.418572678415, 4693.342931989524, 4727.230986520008, 4798.208295631217, 4874.512548745124, 4763.761811909408, 4777.402824646919, 4793.6884102533395, 4841.806327746895, 4923.60611151108, 4345.3047512398025, 4373.934390984138, 4413.051193993291, 4462.5537446255275, 4537.568930951555, 3993.221321842242, 4336.739795612273, 4458.754768487732, 4513.7066090704, 4545.999999999984, 4292.656587472995, 4334.154839806239, 4376.89057773555, 4383.693141480097, 4504.729716217021, 4320.4383430153875, 4359.324304732771, 4389.209942210401, 4406.184855801687, 4479.059397526524, 4347.478302603676, 4348.956510434887, 4388.934165987513, 4403.581659742319, 4427.22523558376, 4727.66906316558, 4756.215224487955, 4765.9523404766205, 4774.785134668949, 4813.422389313269, 4972.87567810804, 5014.24786282057, 5022.221555658879, 5025.296458495814, 5032.874178145539, 5137.357830271216, 5143.7685304161405, 5143.794248230066, 5144.176931690911, 5157.045946499909, 4804.73573953429, 4806.639502037361, 4813.542713442217, 4822.8794280143275, 4835.8065677373215, 5134.589232861362, 5153.974230128825, 5171.4311425743135, 5213.139831927765, 5320.840374788685, 5025.899482010339, 5053.317802096743, 5056.721880296545, 5105.821296254688, 5119.129747942859, 5017.197248440232, 5069.695818250917, 5153.724530003898, 5154.329937108227, 5155.0, 4971.6271279654175, 5018.648694591417, 5030.270610761492, 5083.212102124176, 5106.157484015096, 4968.478309777422, 5024.497550244946, 5027.271045698426, 5028.522290382408, 5070.771815268248, 4242.321228603409, 4242.406063151161, 4307.289297265978, 4314.158739045919, 4375.803088861009, 3755.342815007363, 3755.962440375561, 3760.962390376061, 3795.0512371907025, 3799.848006079781, 4486.573775491323, 4488.102379524108, 4488.39406680094, 4492.73043617384, 4530.433695788027, 5026.0, 5069.340985671913, 5145.536901678792, 5178.585713142939, 5185.196294574347, 4467.754273514923, 4483.50681425043, 4484.573965473275, 4524.02733412318, 4526.049529598821, 4591.311303304465, 4592.173408786383, 4634.050019745944, 4637.976810115928, 4641.582257596832, 4636.489986101458, 4685.226937555265, 4699.177643912233, 4791.305260737104, 4819.108464933998, 5139.511746384088, 5141.100307446257, 5145.253938179018, 5180.715060671549, 5193.870153246199, 4766.094442055998, 4766.880827979328, 4770.928436073392, 4778.139934811628, 4812.326274321527, 4920.40955085392, 4947.381577302837, 5010.849674509771, 5017.698938063728, 5065.3161823153405, 5082.263071854486, 5138.434772174983, 5144.279800827812, 5170.586353091669, 5185.144451165666, 4953.578945789648, 4997.225430058346, 5000.64995450315, 5015.1975683890405, 5045.0, 4858.732769697701, 4877.609791216623, 4914.238293064581, 4915.926261106158, 4965.155923493087, 4949.925751113664, 4950.480199578992, 4959.7272150032095, 4988.476209997898, 5002.399712034579, 5036.967421678474, 5041.949580504148, 5047.2429135629945, 5049.671771334852, 5088.338515992898, 4810.831620893392, 4848.10310092634, 4925.261210818263, 4928.433230178432, 4978.32792572998], "value": 4689.368439990637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.4320096690258, 511.0, 522.7125081205337, 542.4548328929425, 543.893940681567, 29183.708162918363, 38536.61463385366, 40133.59866401335, 40230.0, 40241.79879100608, 41871.162576748444, 42172.78913605428, 42196.0, 42204.155916881646, 42346.57653423465, 7560.546367217957, 7578.545287282767, 7744.612769361509, 7747.109082455505, 7752.341051010642, 7562.924370756305, 9800.852987205197, 10077.0, 10082.697519074403, 10450.111740502029, 10024.548895299693, 10103.696889093302, 10106.848397274047, 10108.595656173744, 10109.34289271195, 9798.804023919518, 9831.213502919749, 9839.55721992512, 9851.261155413373, 9854.359466634682, 9876.506174691236, 9952.502374881227, 9955.25335599833, 9961.501924903798, 9962.900370996342, 38637.61362386368, 38967.0, 39004.92935918312, 39051.80474097611, 39056.414153787715, 3705.5923848376656, 3798.4302354646748, 3803.562590302123, 3822.719389004687, 3859.0931131184147, 29041.41917161666, 29046.709532904613, 29096.27259318534, 29233.415331693246, 30522.542161867368, 3395.405803984293, 3397.8511691584067, 3421.196018935573, 3458.0490365149535, 3460.411730005905, 234978.0, 235997.0, 236486.8175659128, 236539.0, 237497.0, 51243.23135152976, 51692.0, 51840.74079629578, 51855.740721296155, 51916.0, 55005.72497137569, 55101.31638810666, 55107.72446137744, 55166.0, 55219.171712424344, 14567.41730330775, 14816.703665926621, 14822.703545929022, 14824.258787060604, 14836.480723174636, 10343.172546196287, 10644.148468122532, 10867.402292873969, 11012.063974562252, 11205.551777928791, 14916.254187290591, 15412.46056388021, 15509.689806203813, 15559.922200388926, 15710.371585136467, 6144.589752687212, 6166.969165154145, 6180.412860778219, 6318.873622527523, 6425.807225783234, 824.1675907333636, 826.4627991805254, 836.3894357119337, 857.4726543175902, 866.9869951950726, 27096.445228728062, 27685.307867303076, 27811.72188278132, 28022.579661305095, 28402.431951360857, 975.7853272280087, 1003.5835128421769, 1014.4268488304084, 1015.4262841494532, 1018.9184865210765, 13886.305684715724, 14690.41238350454, 15081.396744130112, 15450.38198472071, 15727.213639317988, 338894.0, 340179.0, 340861.0, 341995.0, 342251.0, 43019.78490107529, 43222.78388608037, 43259.351109733376, 43303.783481083025, 43364.13271734548, 1259.962201133949, 1280.0911352939331, 1293.4632127666912, 1296.3388671777273, 1300.8373953256032, 24199.758002420454, 26574.468510630068, 28765.849366025963, 28838.567421488275, 29180.416391672472, 41623.58376416197, 41976.0, 42063.69044643328, 42111.05167647304, 42176.57823421727, 303927.0, 307510.0, 308615.0, 308677.0, 309177.0, 20821.68767468459, 21397.679034814802, 22330.441738956655, 23192.18827341035, 23716.4070898222, 32750.0, 33066.00801975944, 33270.16824579405, 35224.47163292604, 37205.81397092997, 30369.392612148076, 30970.0, 31033.534496983015, 31175.532367014966, 31969.360612788078, 30294.394112117192, 30581.694183057883, 30789.538156928113, 30853.8457307712, 31727.68272317247, 30758.692413075583, 31447.685523145392, 31723.20691982719, 31779.20551986219, 31783.364332713678, 26831.86584067067, 28212.294692632848, 28282.85858570694, 28464.715352846208, 28548.57177142303, 22175.0, 22318.776812232318, 22421.32736017922, 22441.21455749041, 22494.21270255533], "value": 17233.559098648133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.9205928666052, 371.75278439837507, 376.6572419098619, 378.2265267527905, 389.287603685256, 13573.321333933302, 13629.591112266624, 17911.820881791176, 17956.37152699654, 17960.64078718425, 16803.24385402657, 17554.648907021885, 17702.380416685417, 17725.556861078447, 17741.822581774177, 3882.7476214045996, 4891.926621100677, 5077.771500282496, 5082.618803589727, 5087.160618497944, 4084.8570300039505, 5636.18275350074, 5871.1193321001765, 5886.381929897363, 6019.699015049252, 5801.53587712982, 5927.851803704899, 5992.071228959497, 6003.0, 6021.819345419644, 5881.117832325185, 5922.703864806743, 5950.196723442345, 5955.940440595582, 5965.254343207099, 4649.883752906205, 4895.804167833282, 4943.777530011158, 5222.63441559091, 5227.843164705065, 12128.45421956014, 12160.5135794569, 12186.939065304705, 12322.137450378477, 18623.720644190347, 2147.688585155159, 2154.3321570313096, 2161.3083813179787, 2204.1073365287084, 2205.9669104963436, 9500.667476638353, 10539.209559283085, 12859.35703214845, 13068.934655326757, 13799.0, 1669.4073603870695, 1708.666809972056, 1713.1263055841487, 1723.1470422140994, 1746.0745804723517, 64777.0, 76624.0, 78858.0, 80634.59682701608, 82200.17799821925, 8522.446041007439, 9001.63993440255, 9077.228435582918, 9982.058880854023, 10131.189504839742, 11979.820302695467, 12050.939745301217, 12137.089718270989, 12186.0, 12218.144729868824, 5632.2678051853, 5682.7442765075675, 5780.32370612526, 6101.60339577926, 7344.669489872968, 7105.680244389015, 7142.464315176382, 7152.499325047301, 7248.528845625017, 7369.336759691653, 3751.9249615008093, 3784.5647750509042, 3827.942580861289, 3845.538535375717, 3865.903352416212, 1670.2650833633163, 1724.3016578285815, 1726.5769886377918, 1740.7562941188244, 1768.5490199998917, 841.4488510025943, 846.530175752451, 852.3692467573951, 861.4314552395389, 884.4295429448099, 16835.83164168367, 16932.32270709158, 17059.744103838453, 17276.654466910844, 17806.91096544509, 792.6274650914061, 818.2145140664909, 826.4751882554621, 830.4436027861348, 848.321342925657, 5544.722763861791, 5581.265319774539, 5744.834994628861, 5845.357010728816, 5872.471477567039, 572176.3650089706, 573533.0, 575816.0, 588968.0, 591174.0, 93860.0, 95009.52495237617, 95578.0, 95830.52084739531, 96880.0, 1016.4663551635302, 1035.9223058270509, 1057.8677665291993, 1067.8451624514403, 1071.2233630617895, 9459.952700236454, 9484.478353690338, 9549.809003820024, 9558.713238602853, 9986.151177150025, 37050.814745926094, 39053.41419878647, 39280.410793837545, 39602.60397396104, 40427.39358909678, 56528.43471565396, 56611.43388566062, 57656.42343576511, 57886.4211357881, 58151.0, 7666.4633475656165, 7759.340456061298, 7804.687812487664, 7857.371410287049, 7988.3609311253795, 11337.659870203906, 11377.658670239905, 11901.464434100313, 12056.156069075081, 12977.026722996003, 9572.0, 9625.181859541737, 9698.321117521988, 10085.949570252102, 10326.896731032593, 10400.843987340044, 10575.576976921146, 10667.786644266916, 10980.560777569128, 11122.606570404807, 10112.79774404493, 10145.746356341151, 10206.183505319705, 10375.429351385445, 10518.158547316349, 7802.843943121219, 7832.569208693349, 7901.407394445325, 7992.121851365041, 8017.559034253172, 9527.38072025316, 9934.801303973736, 10090.54592543352, 10192.898071019195, 10416.375017498975], "value": 8107.1216105689755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.1014620204462, 1345.703945132071, 1349.6153596225079, 1353.3706826325752, 1360.3062438156537, 6856.862862742742, 7188.71245150194, 7234.96382518088, 7242.710291588343, 7282.890756638648, 6427.903581446282, 6547.57440766351, 6819.693113809878, 6947.8957815632675, 7013.964930175354, 2081.375587323804, 2092.79072092791, 2098.8771007510986, 2100.663893776996, 2104.6632538793797, 2040.8877511736848, 2100.1389430333566, 2109.493721506835, 2110.841686873483, 2114.767375588684, 1813.8820976636543, 1885.962280754384, 1888.5278680329918, 1901.505608541782, 1902.3436914264557, 2027.2195204846093, 2082.3648787119996, 2096.4758810297426, 2118.894055297229, 2119.73503312086, 2052.8049835265774, 2057.0537552725614, 2075.086961736846, 2075.3462659262286, 2079.324219628627, 7068.823279418056, 7093.0, 7123.074000379969, 7190.137183537957, 7280.708771649128, 4261.914761704748, 4286.485621725413, 4310.4611923509565, 4327.848525301631, 4342.696011279212, 2617.149426436397, 2685.261553072901, 2729.672439307276, 2743.3827388837353, 2821.619081424002, 974.668612671695, 1006.0381674210369, 1041.5937784264142, 1055.4933631856675, 1060.241927022175, 9289.767755806091, 9408.482533460658, 9417.76455588609, 9424.34029617927, 9464.858027129598, 3785.4511095891494, 3970.285348637273, 4020.216057868746, 4056.452378928866, 4057.634812866797, 8092.635831387602, 8156.469829461066, 8161.428699991063, 8239.95880020596, 8256.215659512336, 4520.773961301988, 4544.068465964469, 4586.518415566317, 4599.08018396322, 4601.953980460219, 4038.8586399475876, 4104.97375656086, 4204.138151678899, 4208.9789551052045, 4209.989602495379, 3249.6750324967315, 3268.460703983816, 3330.816805075696, 3341.465365541502, 3366.9494957575657, 1073.0700126068361, 1093.9288946218471, 1098.9010989010867, 1101.3777215873006, 1103.172620534599, 581.9225365445319, 642.2453617000007, 830.4477522447505, 854.9478362246844, 882.7219425880827, 4754.096721622881, 4773.0, 4784.497627749106, 4826.806927722922, 4872.0, 899.5637115998735, 913.55235934393, 921.1801496667971, 936.5176933879058, 951.9286053546011, 3306.7685262031428, 3498.440249560058, 3501.439769636897, 3509.105178179599, 3548.6273941236313, 8226.0, 8589.012263589642, 8637.222649961534, 8656.95671521651, 8684.131586841266, 8521.062683104854, 8537.103604121601, 8586.39895207342, 8608.268297194809, 8633.39566230358, 6797.320267973163, 6821.317868213139, 6839.521233513706, 6840.692168852314, 6841.452683785385, 4789.712617242976, 4891.241857512091, 4933.925991110064, 5044.293798868088, 5054.9494505055945, 7496.550206987598, 7840.411969102226, 7862.60686965638, 7905.051393832777, 7942.007249093864, 7713.2286771322415, 7812.101608315116, 7855.5286682799215, 7926.762197134095, 7940.28537431634, 6348.77779277723, 6392.328805475358, 6401.231852177769, 6403.167588213502, 6405.423511883952, 6814.93185068143, 6841.144856892888, 6854.246032936273, 6870.519063665495, 6913.343232392915, 6164.270780837556, 6175.629462232101, 6214.440700336811, 6235.688215589112, 6280.937190628035, 6033.849153771015, 6172.043333283348, 6179.783707570214, 6192.3807619239515, 6201.286852012076, 5385.3268341457315, 5527.2538207341495, 5553.500184983371, 5760.107183386582, 5800.50695690871, 4081.6734661227624, 4110.159409945272, 4123.97938010308, 4153.667706583406, 4173.123644034787, 4322.416473776, 4382.101669157879, 4437.3343998399205, 4457.242268814244, 4524.072565124207], "value": 3858.204557396921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.58116469654067, 348.79944032181504, 350.91928856363035, 356.5863598226057, 361.33514333626124, 4841.273808928658, 4876.268559716044, 4893.755312234387, 4894.339264199332, 4904.583110435608, 4808.3989501312335, 4815.494373090827, 4825.638077144211, 4829.179039563274, 4835.549335199435, 3412.7952322860583, 3685.815709214542, 3755.6619904208615, 3844.5386553613607, 3901.0637447012728, 3815.5993620669847, 3821.9808900955454, 3830.655241028307, 3831.4061320495366, 3839.9424008639894, 3828.731988760774, 3839.731218814684, 3842.769433833979, 3850.6919446444217, 3854.3640299350573, 3687.50218720472, 3747.4378843173467, 3803.6006219346846, 3859.536855577335, 3865.690744740414, 3448.6034106077873, 3464.4803279508023, 3472.947905781415, 3473.235888104613, 3475.2701932594186, 4707.976460117678, 4724.984128412373, 4726.598239149642, 4731.952680473186, 4753.524647535253, 4321.114171594815, 4409.250427427345, 4421.447319085114, 4430.734155950621, 4432.711873728197, 5044.419891712463, 5063.620228482841, 5069.188929771219, 5082.288479612857, 5083.262926875619, 3798.9810050949845, 3818.198178382543, 3824.0822202671156, 3830.616938306175, 3837.808109594537, 5097.49025097491, 5261.789528418897, 5365.946340536622, 5369.147644062792, 5383.488568585978, 3797.3354662933875, 3872.8838134856, 3888.766673999569, 3889.871937138198, 3896.123372241223, 3912.9021774455296, 3946.960530394717, 3963.2667956428154, 3971.0, 3990.7206495545615, 4420.0, 4421.955780442218, 4424.911501769947, 4470.619997300201, 4471.35165401015, 4925.556699897026, 5071.949280507221, 5072.543471087546, 5086.109930762102, 5086.567641750493, 1331.181323486049, 1350.1156742333787, 1353.3827076643317, 1355.8915286777035, 1361.3125371687236, 930.567587824748, 967.5742673223759, 973.9481360131041, 978.6232300564334, 979.275336251169, 4328.653707703376, 4332.916770807298, 4336.891577710582, 4339.804708788112, 4367.192069467159, 5055.797768089235, 5059.2916991621205, 5067.797288108434, 5081.364829396325, 5103.826119992423, 4241.703080784378, 4322.827086916551, 4347.413099231563, 4356.0, 4368.847090351823, 2682.181934509993, 2691.838489690625, 2707.3502359433987, 2717.972820271772, 2722.4555088982283, 4760.642951778561, 4790.640701947368, 4792.161371759928, 4806.206975849016, 4808.927866082012, 5033.3205017322925, 5194.896102077937, 5214.348206474191, 5230.8169214077325, 5236.941370437941, 4914.287428322873, 4930.531599498042, 4936.605071594264, 4938.9012219755405, 4939.3084968104495, 5219.76511057011, 5243.397009343974, 5244.737763111905, 5247.0, 5257.526822585985, 4927.852164435073, 5118.0, 5144.9742751286, 5159.767810448464, 5160.535551800356, 4690.200937240846, 4749.857504274739, 4809.759512024315, 4896.485868983706, 4917.237828136645, 3673.651003154696, 3680.8159592019756, 3683.9263214736093, 3687.6681098701247, 3710.443433484891, 5238.292830467838, 5285.260063591178, 5285.286486324297, 5287.68273903567, 5290.550303224269, 4963.503649635008, 5065.316182315488, 5070.847874563769, 5101.617378696538, 5104.9744751276, 5063.556886287391, 5078.597339782428, 5080.161773307363, 5084.161113416245, 5101.0, 5008.474110218374, 5018.473060328759, 5025.6482046256415, 5041.445441001413, 5046.1673823818655, 5002.620467333063, 5004.047611908991, 5088.338515992898, 5092.923606145985, 5111.821086261963, 4956.628252880976, 4958.058343616761, 4986.401631804061, 4986.551210391082, 4988.351514303117], "value": 3872.920317057448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.5058654249686, 663.7444583835226, 723.2694978072145, 760.3612965109307, 776.4797585617638, 12324.63026109217, 12970.74058518829, 12991.285479298635, 13013.804792928102, 13014.284214368217, 13218.801717974238, 13450.1257418268, 13456.125351852123, 13463.394147263372, 13474.865251347484, 658.8879890418616, 674.9730010799562, 791.683326669334, 796.9880451793227, 806.6370133439946, 804.3283857978565, 818.4557269415832, 819.5205804604313, 819.737683941139, 819.8483280593109, 876.4565969099167, 876.776422012386, 877.8024944387525, 877.863931090682, 877.9604917778715, 689.1007235557595, 703.2299631903059, 840.4117118017413, 874.4665753890154, 874.637025634361, 627.3068259573151, 630.6058713304185, 630.6562923206864, 631.0534198701947, 631.3244828034005, 13437.66405839852, 13458.798118028237, 13468.0, 13472.326383680776, 13477.393517291745, 12745.745085098339, 12789.808152877715, 12828.999999999907, 12945.87054129456, 12999.1550549214, 11343.829842552368, 11530.827037594443, 11540.0, 11739.530418783239, 11847.881521184763, 4034.616711412411, 4170.270202714512, 4250.298700714378, 4261.21167583998, 4276.679249056333, 62445.37554624487, 63921.360786392004, 64017.0, 64135.0, 65261.67369163124, 10324.535395907202, 10325.277230593936, 10460.581576736997, 10480.371177729361, 10681.46592670379, 19682.70475942862, 19690.507737306394, 19705.11326990289, 19713.704294435596, 19717.0, 6539.149910511603, 6593.7362505500205, 6612.7354905804195, 6745.258021617618, 6872.896906546406, 3546.911327216789, 3560.2701446203464, 3590.2281009583066, 3593.8742144025355, 3641.435577485441, 2747.738964798341, 2792.4135931454216, 2815.366542527915, 2825.477286701967, 2827.7275226148317, 484.6776893365872, 492.12156301003256, 499.34835040272793, 505.11856809867015, 506.26844210116764, 525.5401523666792, 531.325216974448, 535.154455959583, 605.3492495567283, 643.9323870993572, 8647.351448641377, 8979.955100224457, 9004.36969412148, 9140.90859091414, 9317.813643727088, 503.8916632923939, 519.3300642171556, 519.3326575350657, 558.0178885162144, 621.7077973352517, 4181.456410666655, 4327.480702315679, 4373.0, 4388.4733831940375, 4438.4451943507065, 62418.0637290441, 62434.37565624285, 63094.684526577075, 66330.0, 66484.0, 54998.17502737462, 55987.16019259714, 57033.42966570281, 57587.42412575905, 58025.70987145122, 39053.02367440837, 40707.185856282114, 42023.7898810504, 42559.787201063795, 49668.75165624149, 9459.858102128335, 10045.899541004497, 10091.79816403653, 10162.542685579314, 10167.237457190593, 32601.18497037593, 32695.18262043468, 33479.83260083684, 33577.2991781146, 34006.0, 39957.20085598213, 40144.59855401408, 40607.3908891361, 40774.18451630892, 40911.590884091966, 11010.119190464904, 11130.276532025393, 11220.887791122312, 11241.213115082193, 11382.430878456209, 12528.248305101723, 12594.27560045532, 12826.166299190523, 13312.534061307808, 13360.532381366605, 11904.464299106388, 12304.446299916346, 12628.431720572413, 13016.0, 13033.543825966424, 12148.0, 12549.623511294676, 12859.742805143658, 13041.217526948414, 13320.93339533296, 11510.44220264349, 11992.820107698217, 12032.699182520508, 12146.0, 12232.87767122353, 10376.27366084397, 10645.361278323326, 10650.147988160774, 10664.200184986312, 10691.625793097204, 8759.299256059627, 9593.232541396812, 10114.140298074451, 10114.190864730952, 10135.290529663147], "value": 6372.375932124758, "unit": "score"}], "name": "dromaeo_css", "value": 6297.796364364854, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 116.0, 114.0, 114.0, 114.0, 113.0, 112.0, 116.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 125.0, 153.0, 129.0, 123.0, 128.0, 130.0, 158.0, 125.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 161.0, 163.0, 163.0, 160.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 105.0, 78.0, 78.0, 78.0, 78.0, 93.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 85.0, 86.0, 84.0, 97.0, 85.0, 85.0, 102.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 61.0, 61.0, 59.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 87.0, 96.0, 90.0, 84.0, 95.0, 89.0, 84.0, 86.0, 85.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 148.0, 134.0, 132.0, 133.0, 140.0, 133.0, 179.0, 153.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 175.0, 181.0, 179.0, 177.0, 181.0, 181.0, 177.0, 179.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 71.0, 67.0, 68.0, 68.0, 68.0, 71.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1550.6000000000001, "alertThreshold": 2.0}]} 02:15:20 INFO - Return code: 0 02:15:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:15:20 INFO - # TBPL SUCCESS # 02:15:20 INFO - Running post-action listener: _resource_record_post_action 02:15:20 INFO - [mozharness: 2017-01-10 10:15:20.450229Z] Finished run-tests step (success) 02:15:20 INFO - Running post-run listener: _resource_record_post_run 02:15:20 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 208896; Write bytes: 381616128; Read time: 200; Write time: 398788 02:15:20 INFO - TinderboxPrint: CPU usage
13.1% 02:15:20 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 200 02:15:20 INFO - TinderboxPrint: I/O write bytes / time
381,616,128 / 398,788 02:15:20 INFO - TinderboxPrint: CPU idle
8,344.7 (86.9%) 02:15:20 INFO - TinderboxPrint: CPU user
1,212.1 (12.6%) 02:15:20 INFO - TinderboxPrint: Swap in / out
0 / 0 02:15:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99680256; Read time: 0; Write time: 160608 02:15:20 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 204800; Write bytes: 281554944; Read time: 188; Write time: 238152 02:15:21 INFO - Running post-run listener: _upload_blobber_files 02:15:21 INFO - Blob upload gear active. 02:15:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:15:21 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 02:15:21 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:15:21 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:15:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:22 INFO - (blobuploader) - INFO - Done attempting. 02:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:26 INFO - (blobuploader) - INFO - Done attempting. 02:15:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:15:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:27 INFO - (blobuploader) - INFO - Done attempting. 02:15:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:15:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:15:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:28 INFO - (blobuploader) - INFO - Done attempting. 02:15:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:15:28 INFO - Return code: 0 02:15:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:15:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:15:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c2ce782e09bc5552bd9d22a26e9b29dea5a6e780608c07ac3b0ebd6e8bcc175b5920b6510b948885194dc1f5532841cd5000399cc08f38756e9df67a6d75e593", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/907abec020bd2466537acdf42e5ed8992876aad2b0152fd18510ff51c1a6fdf3d2849e46cfba8d8c5abf25c979b52b8a55018bb41fe79b57053f45832e8eb72b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6721d040dd6db69d970b0ede3fed293aa8e0b62a92f7ba29cb392986431868048f67212d96677eba4ffce50b0a5d4f575d7f01b8c21e39ab9210b2a5f19ca2e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b70594d8e71b907a27cb59ae700daf1319dd2d735d6157d75c5db4960040599b5653045558ccc13330b9d1f8e1a1d9acf9b1b712923ec6c81a010e64a2839653"} 02:15:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:15:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:15:28 INFO - Contents: 02:15:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c2ce782e09bc5552bd9d22a26e9b29dea5a6e780608c07ac3b0ebd6e8bcc175b5920b6510b948885194dc1f5532841cd5000399cc08f38756e9df67a6d75e593", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/907abec020bd2466537acdf42e5ed8992876aad2b0152fd18510ff51c1a6fdf3d2849e46cfba8d8c5abf25c979b52b8a55018bb41fe79b57053f45832e8eb72b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6721d040dd6db69d970b0ede3fed293aa8e0b62a92f7ba29cb392986431868048f67212d96677eba4ffce50b0a5d4f575d7f01b8c21e39ab9210b2a5f19ca2e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b70594d8e71b907a27cb59ae700daf1319dd2d735d6157d75c5db4960040599b5653045558ccc13330b9d1f8e1a1d9acf9b1b712923ec6c81a010e64a2839653"} 02:15:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:15:28 INFO - Copying logs to upload dir... 02:15:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:15:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.873742 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-01-10 02:15:28.071940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:28.075527) ========= 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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c2ce782e09bc5552bd9d22a26e9b29dea5a6e780608c07ac3b0ebd6e8bcc175b5920b6510b948885194dc1f5532841cd5000399cc08f38756e9df67a6d75e593", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/907abec020bd2466537acdf42e5ed8992876aad2b0152fd18510ff51c1a6fdf3d2849e46cfba8d8c5abf25c979b52b8a55018bb41fe79b57053f45832e8eb72b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6721d040dd6db69d970b0ede3fed293aa8e0b62a92f7ba29cb392986431868048f67212d96677eba4ffce50b0a5d4f575d7f01b8c21e39ab9210b2a5f19ca2e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b70594d8e71b907a27cb59ae700daf1319dd2d735d6157d75c5db4960040599b5653045558ccc13330b9d1f8e1a1d9acf9b1b712923ec6c81a010e64a2839653"} build_url:https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011852 build_url: 'https://queue.taskcluster.net/v1/task/GKsmARG4RIeFwTPkb8pH3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c2ce782e09bc5552bd9d22a26e9b29dea5a6e780608c07ac3b0ebd6e8bcc175b5920b6510b948885194dc1f5532841cd5000399cc08f38756e9df67a6d75e593", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/907abec020bd2466537acdf42e5ed8992876aad2b0152fd18510ff51c1a6fdf3d2849e46cfba8d8c5abf25c979b52b8a55018bb41fe79b57053f45832e8eb72b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6721d040dd6db69d970b0ede3fed293aa8e0b62a92f7ba29cb392986431868048f67212d96677eba4ffce50b0a5d4f575d7f01b8c21e39ab9210b2a5f19ca2e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b70594d8e71b907a27cb59ae700daf1319dd2d735d6157d75c5db4960040599b5653045558ccc13330b9d1f8e1a1d9acf9b1b712923ec6c81a010e64a2839653"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:28.103799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:28.104144) ========= 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=5bd038846534b2fdfa68eeae000001e2-1484040986.442257-1624422832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 02:15:28.187928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 02:15:28.188271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 02:15:28.188577) ========= ========= Total master_lag: 0.16 =========