builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1491903075.28 results: success (0) revision: 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.277587) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.278385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.278703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.359667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.360037) ========= 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=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-11 02:31:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-04-11 02:31:16 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.475743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.476046) ========= 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=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019686 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:15.525120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 02:31:15.525444) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 --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=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-11 02:31:16,455 truncating revision to first 12 chars 2017-04-11 02:31:16,455 Setting DEBUG logging. 2017-04-11 02:31:16,455 attempt 1/10 2017-04-11 02:31:16,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/830c7fcc3e73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 02:31:17,171 unpacking tar archive at: mozilla-central-830c7fcc3e73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 02:31:16.567832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:16.568215) ========= script_repo_revision: 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:16.568646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:16.568908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 02:31:16.578935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-11 02:31:16.579317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:17 INFO - MultiFileLogger online at 20170411 02:31:17 in /builds/slave/test 02:31:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:31:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:17 INFO - {'append_to_log': False, 02:31:17 INFO - 'base_work_dir': '/builds/slave/test', 02:31:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:31:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:17 INFO - 'branch': 'Firefox-Non-PGO', 02:31:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:17 INFO - 'config_files': ('talos/linux_config.py',), 02:31:17 INFO - 'default_actions': ('clobber', 02:31:17 INFO - 'read-buildbot-config', 02:31:17 INFO - 'download-and-extract', 02:31:17 INFO - 'populate-webroot', 02:31:17 INFO - 'create-virtualenv', 02:31:17 INFO - 'install', 02:31:17 INFO - 'run-tests'), 02:31:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:17 INFO - 'download_minidump_stackwalk': True, 02:31:17 INFO - 'download_symbols': 'ondemand', 02:31:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:17 INFO - 'gecko_profile': False, 02:31:17 INFO - 'gecko_profile_interval': 0, 02:31:17 INFO - 'installer_path': 'installer.exe', 02:31:17 INFO - 'log_level': 'info', 02:31:17 INFO - 'log_name': 'talos', 02:31:17 INFO - 'log_to_console': True, 02:31:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:17 INFO - 'opt_config_files': (), 02:31:17 INFO - 'pip_index': False, 02:31:17 INFO - 'suite': 'dromaeojs', 02:31:17 INFO - 'system_bits': '32', 02:31:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:17 INFO - 'title': 'talos-linux64-ix-053', 02:31:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:17 INFO - 'use_talos_json': True, 02:31:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:17 INFO - 'work_dir': 'build'} 02:31:17 INFO - [mozharness: 2017-04-11 09:31:17.610768Z] Running clobber step. 02:31:17 INFO - Running pre-action listener: _resource_record_pre_action 02:31:17 INFO - Running main action method: clobber 02:31:17 INFO - rmtree: /builds/slave/test/build 02:31:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:18 INFO - Running post-action listener: _resource_record_post_action 02:31:18 INFO - [mozharness: 2017-04-11 09:31:18.629023Z] Finished clobber step (success) 02:31:18 INFO - [mozharness: 2017-04-11 09:31:18.629123Z] Running read-buildbot-config step. 02:31:18 INFO - Running pre-action listener: _resource_record_pre_action 02:31:18 INFO - Running main action method: read_buildbot_config 02:31:18 INFO - Using buildbot properties: 02:31:18 INFO - { 02:31:18 INFO - "project": "", 02:31:18 INFO - "product": "firefox", 02:31:18 INFO - "who": "ffxbld@noreply.mozilla.org", 02:31:18 INFO - "installer_path": "public/build/target.tar.bz2", 02:31:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:31:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:31:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:31:18 INFO - "stage_platform": "linux64", 02:31:18 INFO - "basedir": "/builds/slave/test", 02:31:18 INFO - "buildnumber": 1065, 02:31:18 INFO - "platform": "ubuntu64_hw", 02:31:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:31:18 INFO - "slavebuilddir": "test", 02:31:18 INFO - "taskId": "dCgY4K_CTauRumny4a0wtg", 02:31:18 INFO - "branch": "mozilla-central", 02:31:18 INFO - "script_repo_revision": "production", 02:31:18 INFO - "revision": "830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12", 02:31:18 INFO - "slavename": "talos-linux64-ix-053", 02:31:18 INFO - "repo_path": "mozilla-central" 02:31:18 INFO - } 02:31:18 INFO - Finding installer, test and symbols from parent task. 02:31:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dCgY4K_CTauRumny4a0wtg'}, attempt #1 02:31:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dCgY4K_CTauRumny4a0wtg'}, attempt #1 02:31:19 INFO - Task dependencies: G8XojSVKR6KoaiMmNIUe1A 02:31:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A'}, attempt #1 02:31:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 02:31:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/test_packages.json 02:31:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.crashreporter-symbols.zip 02:31:19 INFO - Running post-action listener: _resource_record_post_action 02:31:19 INFO - [mozharness: 2017-04-11 09:31:19.985036Z] Finished read-buildbot-config step (success) 02:31:19 INFO - [mozharness: 2017-04-11 09:31:19.985253Z] Running download-and-extract step. 02:31:19 INFO - Running pre-action listener: _resource_record_pre_action 02:31:19 INFO - Running main action method: download_and_extract 02:31:19 INFO - mkdir: /builds/slave/test/build/tests 02:31:19 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')]} 02:31:19 INFO - trying https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.test_packages.json 02:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:31:20 INFO - Downloaded 986 bytes. 02:31:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:31:20 INFO - Using the following test package requirements: 02:31:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:31:20 INFO - u'common': [u'target.common.tests.zip'], 02:31:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:31:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:31:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:31:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:31:20 INFO - u'mozbase': [u'target.common.tests.zip'], 02:31:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:31:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:31:20 INFO - u'web-platform': [u'target.common.tests.zip', 02:31:20 INFO - u'target.web-platform.tests.zip'], 02:31:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:31:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:31:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip 02:31:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:31:20 INFO - Fetch https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip into memory 02:31:21 INFO - Expected file size: 58301641 02:31:21 INFO - Obtained file size: 58301641 02:31:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip 02:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.common.tests.zip into memory 02:31:32 INFO - Expected file size: 58301641 02:31:32 INFO - Obtained file size: 58301641 02:31:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.talos.tests.zip 02:31:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:31:43 INFO - Fetch https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.talos.tests.zip into memory 02:31:44 INFO - Expected file size: 14405596 02:31:44 INFO - Obtained file size: 14405596 02:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:44 INFO - trying https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 02:31:44 INFO - Downloading https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:31:45 INFO - Downloaded 57762897 bytes. 02:31:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 02:31:45 INFO - mkdir: /builds/slave/test/properties 02:31:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:45 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:45 INFO - Contents: 02:31:45 INFO - build_url:https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 02:31:45 INFO - Running post-action listener: _resource_record_post_action 02:31:45 INFO - Running post-action listener: set_extra_try_arguments 02:31:45 INFO - [mozharness: 2017-04-11 09:31:45.797102Z] Finished download-and-extract step (success) 02:31:45 INFO - [mozharness: 2017-04-11 09:31:45.797199Z] Running populate-webroot step. 02:31:45 INFO - Running pre-action listener: _resource_record_pre_action 02:31:45 INFO - Running main action method: populate_webroot 02:31:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:31:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:31:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:31:45 INFO - '--tppagecycles', 02:31:45 INFO - '7'], 02:31:45 INFO - 'tests': ['tsvgm']}}, 02:31:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:31:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:31:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['damp', 'tps']}, 02:31:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'tests': ['damp', 'tps']}, 02:31:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['dromaeo_dom']}, 02:31:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['basic_compositor_video']}, 02:31:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:31:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['a11yr', 02:31:45 INFO - 'ts_paint', 02:31:45 INFO - 'tpaint', 02:31:45 INFO - 'sessionrestore', 02:31:45 INFO - 'sessionrestore_no_auto_restore', 02:31:45 INFO - 'tabpaint']}, 02:31:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['tsvgx', 02:31:45 INFO - 'tsvgr_opacity', 02:31:45 INFO - 'tart', 02:31:45 INFO - 'tscrollx', 02:31:45 INFO - 'cart', 02:31:45 INFO - 'tsvg_static']}, 02:31:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:45 INFO - 'tsvgr_opacity', 02:31:45 INFO - 'tart', 02:31:45 INFO - 'tscrollx', 02:31:45 INFO - 'cart', 02:31:45 INFO - 'tsvg_static']}, 02:31:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'talos_options': ['--disable-e10s'], 02:31:45 INFO - 'tests': ['tp5o']}, 02:31:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:31:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'talos_options': ['--disable-e10s', 02:31:45 INFO - '--xperf_path', 02:31:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:45 INFO - 'tests': ['tp5n']}, 02:31:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:31:45 INFO - 'talos_options': ['--xperf_path', 02:31:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:45 INFO - 'tests': ['tp5n']}}, 02:31:45 INFO - 'talos.zip': {'path': '', 02:31:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:31:45 INFO - Running post-action listener: _resource_record_post_action 02:31:45 INFO - [mozharness: 2017-04-11 09:31:45.810382Z] Finished populate-webroot step (success) 02:31:45 INFO - [mozharness: 2017-04-11 09:31:45.810471Z] Running create-virtualenv step. 02:31:45 INFO - Running pre-action listener: _resource_record_pre_action 02:31:45 INFO - Running main action method: create_virtualenv 02:31:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:45 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 02:31:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:31:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:45 INFO - Using real prefix '/usr' 02:31:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:31:48 INFO - Installing pip.................done. 02:31:48 INFO - Return code: 0 02:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:31:48 INFO - Reading from file tmpfile_stdout 02:31:48 INFO - Output received: 02:31:48 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) 02:31:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:31:48 INFO - Using env: {'DISPLAY': ':0', 02:31:48 INFO - 'HOME': '/home/cltbld', 02:31:48 INFO - 'LANG': 'en_US.UTF-8', 02:31:48 INFO - 'LANGUAGE': 'en_US:en', 02:31:48 INFO - 'LOGNAME': 'cltbld', 02:31:48 INFO - 'MAIL': '/var/mail/cltbld', 02:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:48 INFO - 'MOZ_NO_REMOTE': '1', 02:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:48 INFO - 'NO_EM_RESTART': '1', 02:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:48 INFO - 'PWD': '/builds/slave/test', 02:31:48 INFO - 'SHELL': '/bin/bash', 02:31:48 INFO - 'SHLVL': '1', 02:31:48 INFO - 'TERM': 'linux', 02:31:48 INFO - 'TMOUT': '86400', 02:31:48 INFO - 'USER': 'cltbld', 02:31:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:48 INFO - '_': '/tools/buildbot/bin/python'} 02:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:48 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 02:31:48 INFO - Cleaning up... 02:31:48 INFO - Return code: 0 02:31:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:31:48 INFO - Using env: {'DISPLAY': ':0', 02:31:48 INFO - 'HOME': '/home/cltbld', 02:31:48 INFO - 'LANG': 'en_US.UTF-8', 02:31:48 INFO - 'LANGUAGE': 'en_US:en', 02:31:48 INFO - 'LOGNAME': 'cltbld', 02:31:48 INFO - 'MAIL': '/var/mail/cltbld', 02:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:48 INFO - 'MOZ_NO_REMOTE': '1', 02:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:48 INFO - 'NO_EM_RESTART': '1', 02:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:48 INFO - 'PWD': '/builds/slave/test', 02:31:48 INFO - 'SHELL': '/bin/bash', 02:31:48 INFO - 'SHLVL': '1', 02:31:48 INFO - 'TERM': 'linux', 02:31:48 INFO - 'TMOUT': '86400', 02:31:48 INFO - 'USER': 'cltbld', 02:31:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:48 INFO - '_': '/tools/buildbot/bin/python'} 02:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:49 INFO - Downloading/unpacking psutil>=3.1.1 02:31:49 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 02:31:49 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 02:31:49 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 02:31:49 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 02:31:49 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 02:31:49 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 02:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:51 INFO - Installing collected packages: psutil 02:31:51 INFO - Running setup.py install for psutil 02:31:51 INFO - building 'psutil._psutil_linux' extension 02:31:51 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 02:31:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:31:51 INFO - building 'psutil._psutil_posix' extension 02:31:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:31:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:51 INFO - Successfully installed psutil 02:31:51 INFO - Cleaning up... 02:31:51 INFO - Return code: 0 02:31:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:31:51 INFO - Using env: {'DISPLAY': ':0', 02:31:51 INFO - 'HOME': '/home/cltbld', 02:31:51 INFO - 'LANG': 'en_US.UTF-8', 02:31:51 INFO - 'LANGUAGE': 'en_US:en', 02:31:51 INFO - 'LOGNAME': 'cltbld', 02:31:51 INFO - 'MAIL': '/var/mail/cltbld', 02:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:51 INFO - 'MOZ_NO_REMOTE': '1', 02:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:51 INFO - 'NO_EM_RESTART': '1', 02:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:51 INFO - 'PWD': '/builds/slave/test', 02:31:51 INFO - 'SHELL': '/bin/bash', 02:31:51 INFO - 'SHLVL': '1', 02:31:51 INFO - 'TERM': 'linux', 02:31:51 INFO - 'TMOUT': '86400', 02:31:51 INFO - 'USER': 'cltbld', 02:31:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:51 INFO - '_': '/tools/buildbot/bin/python'} 02:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:31:51 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 02:31:51 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 02:31:51 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 02:31:51 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 02:31:51 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 02:31:51 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 02:31:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:31:54 INFO - Installing collected packages: mozsystemmonitor 02:31:54 INFO - Running setup.py install for mozsystemmonitor 02:31:54 INFO - Successfully installed mozsystemmonitor 02:31:54 INFO - Cleaning up... 02:31:54 INFO - Return code: 0 02:31:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:31:54 INFO - Using env: {'DISPLAY': ':0', 02:31:54 INFO - 'HOME': '/home/cltbld', 02:31:54 INFO - 'LANG': 'en_US.UTF-8', 02:31:54 INFO - 'LANGUAGE': 'en_US:en', 02:31:54 INFO - 'LOGNAME': 'cltbld', 02:31:54 INFO - 'MAIL': '/var/mail/cltbld', 02:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:54 INFO - 'MOZ_NO_REMOTE': '1', 02:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:54 INFO - 'NO_EM_RESTART': '1', 02:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:54 INFO - 'PWD': '/builds/slave/test', 02:31:54 INFO - 'SHELL': '/bin/bash', 02:31:54 INFO - 'SHLVL': '1', 02:31:54 INFO - 'TERM': 'linux', 02:31:54 INFO - 'TMOUT': '86400', 02:31:54 INFO - 'USER': 'cltbld', 02:31:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:54 INFO - '_': '/tools/buildbot/bin/python'} 02:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:31:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:31:56 INFO - warning: no files found matching '*.txt' 02:31:56 INFO - no previously-included directories found matching 'build' 02:31:56 INFO - no previously-included directories found matching 'dist' 02:31:56 INFO - no previously-included directories found matching '.git*' 02:31:56 INFO - Installing collected packages: jsonschema, functools32 02:31:56 INFO - Running setup.py install for functools32 02:31:56 INFO - warning: no files found matching '*.txt' 02:31:56 INFO - no previously-included directories found matching 'build' 02:31:56 INFO - no previously-included directories found matching 'dist' 02:31:56 INFO - no previously-included directories found matching '.git*' 02:31:56 INFO - Successfully installed jsonschema functools32 02:31:56 INFO - Cleaning up... 02:31:56 INFO - Return code: 0 02:31:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:31:56 INFO - Using env: {'DISPLAY': ':0', 02:31:56 INFO - 'HOME': '/home/cltbld', 02:31:56 INFO - 'LANG': 'en_US.UTF-8', 02:31:56 INFO - 'LANGUAGE': 'en_US:en', 02:31:56 INFO - 'LOGNAME': 'cltbld', 02:31:56 INFO - 'MAIL': '/var/mail/cltbld', 02:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:56 INFO - 'MOZ_NO_REMOTE': '1', 02:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:56 INFO - 'NO_EM_RESTART': '1', 02:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:56 INFO - 'PWD': '/builds/slave/test', 02:31:56 INFO - 'SHELL': '/bin/bash', 02:31:56 INFO - 'SHLVL': '1', 02:31:56 INFO - 'TERM': 'linux', 02:31:56 INFO - 'TMOUT': '86400', 02:31:56 INFO - 'USER': 'cltbld', 02:31:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:56 INFO - '_': '/tools/buildbot/bin/python'} 02:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:31:57 INFO - Cleaning up... 02:31:57 INFO - Return code: 0 02:31:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31: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')]} 02:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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')]} 02:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31: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', '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 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:31: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 blobuploader==1.2.4 02:31:57 INFO - Using env: {'DISPLAY': ':0', 02:31:57 INFO - 'HOME': '/home/cltbld', 02:31:57 INFO - 'LANG': 'en_US.UTF-8', 02:31:57 INFO - 'LANGUAGE': 'en_US:en', 02:31:57 INFO - 'LOGNAME': 'cltbld', 02:31:57 INFO - 'MAIL': '/var/mail/cltbld', 02:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:57 INFO - 'MOZ_NO_REMOTE': '1', 02:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:57 INFO - 'NO_EM_RESTART': '1', 02:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:57 INFO - 'PWD': '/builds/slave/test', 02:31:57 INFO - 'SHELL': '/bin/bash', 02:31:57 INFO - 'SHLVL': '1', 02:31:57 INFO - 'TERM': 'linux', 02:31:57 INFO - 'TMOUT': '86400', 02:31:57 INFO - 'USER': 'cltbld', 02:31:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:57 INFO - '_': '/tools/buildbot/bin/python'} 02:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:31: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 02:31: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 02:31: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 02:31: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 02:31: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 02:31: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 02:31:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:00 INFO - Downloading docopt-0.6.1.tar.gz 02:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:00 INFO - Running setup.py install for blobuploader 02:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:00 INFO - Running setup.py install for requests 02:32:00 INFO - Running setup.py install for docopt 02:32:00 INFO - Successfully installed blobuploader requests docopt 02:32:00 INFO - Cleaning up... 02:32:00 INFO - Return code: 0 02:32:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:00 INFO - Using env: {'DISPLAY': ':0', 02:32:00 INFO - 'HOME': '/home/cltbld', 02:32:00 INFO - 'LANG': 'en_US.UTF-8', 02:32:00 INFO - 'LANGUAGE': 'en_US:en', 02:32:00 INFO - 'LOGNAME': 'cltbld', 02:32:00 INFO - 'MAIL': '/var/mail/cltbld', 02:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:00 INFO - 'MOZ_NO_REMOTE': '1', 02:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:00 INFO - 'NO_EM_RESTART': '1', 02:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:00 INFO - 'PWD': '/builds/slave/test', 02:32:00 INFO - 'SHELL': '/bin/bash', 02:32:00 INFO - 'SHLVL': '1', 02:32:00 INFO - 'TERM': 'linux', 02:32:00 INFO - 'TMOUT': '86400', 02:32:00 INFO - 'USER': 'cltbld', 02:32:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:00 INFO - '_': '/tools/buildbot/bin/python'} 02:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:01 INFO - Running setup.py (path:/tmp/pip-bmmG1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:01 INFO - Running setup.py (path:/tmp/pip-UchrMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:01 INFO - Running setup.py (path:/tmp/pip-QGYTLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:01 INFO - Running setup.py (path:/tmp/pip-21QDnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:01 INFO - Running setup.py (path:/tmp/pip-5ZoWPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:01 INFO - Running setup.py (path:/tmp/pip-4u2E4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:01 INFO - Running setup.py (path:/tmp/pip-h4cEtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:01 INFO - Running setup.py (path:/tmp/pip-u7VVdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:01 INFO - Running setup.py (path:/tmp/pip-nKfuva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:01 INFO - Running setup.py (path:/tmp/pip-liPF_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:01 INFO - Running setup.py (path:/tmp/pip-UWVjjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:01 INFO - Running setup.py (path:/tmp/pip-tXq1M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:01 INFO - Running setup.py (path:/tmp/pip-Rdxc5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:01 INFO - Running setup.py (path:/tmp/pip-tkl_NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:02 INFO - Running setup.py (path:/tmp/pip-Dex3kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:02 INFO - Running setup.py (path:/tmp/pip-83GVGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:02 INFO - Running setup.py (path:/tmp/pip-4Hv5ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:02 INFO - Running setup.py install for manifestparser 02:32:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozcrash 02:32:02 INFO - Running setup.py install for mozdebug 02:32:02 INFO - Running setup.py install for mozdevice 02:32:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozfile 02:32:02 INFO - Running setup.py install for mozhttpd 02:32:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozinfo 02:32:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozInstall 02:32:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Running setup.py install for mozleak 02:32:03 INFO - Running setup.py install for mozlog 02:32:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Running setup.py install for moznetwork 02:32:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Running setup.py install for mozprocess 02:32:03 INFO - Running setup.py install for mozprofile 02:32:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Running setup.py install for mozrunner 02:32:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Running setup.py install for mozscreenshot 02:32:03 INFO - Running setup.py install for moztest 02:32:03 INFO - Running setup.py install for mozversion 02:32:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:03 INFO - Cleaning up... 02:32:04 INFO - Return code: 0 02:32:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:04 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')]} 02:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:04 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')]} 02:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:04 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 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:32:04 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 02:32:04 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 02:32:04 INFO - Using env: {'DISPLAY': ':0', 02:32:04 INFO - 'HOME': '/home/cltbld', 02:32:04 INFO - 'LANG': 'en_US.UTF-8', 02:32:04 INFO - 'LANGUAGE': 'en_US:en', 02:32:04 INFO - 'LOGNAME': 'cltbld', 02:32:04 INFO - 'MAIL': '/var/mail/cltbld', 02:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:04 INFO - 'MOZ_NO_REMOTE': '1', 02:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:04 INFO - 'NO_EM_RESTART': '1', 02:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:04 INFO - 'PWD': '/builds/slave/test', 02:32:04 INFO - 'SHELL': '/bin/bash', 02:32:04 INFO - 'SHLVL': '1', 02:32:04 INFO - 'TERM': 'linux', 02:32:04 INFO - 'TMOUT': '86400', 02:32:04 INFO - 'USER': 'cltbld', 02:32:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:04 INFO - '_': '/tools/buildbot/bin/python'} 02:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:04 INFO - Running setup.py (path:/tmp/pip-h4fOun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:04 INFO - Running setup.py (path:/tmp/pip-58luaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:04 INFO - Running setup.py (path:/tmp/pip-ujJyP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:04 INFO - Running setup.py (path:/tmp/pip-o3SbcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:04 INFO - Running setup.py (path:/tmp/pip-vpbuMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:04 INFO - Running setup.py (path:/tmp/pip-57mUek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:04 INFO - Running setup.py (path:/tmp/pip-IePrEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:04 INFO - Running setup.py (path:/tmp/pip-5IfGr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:04 INFO - Running setup.py (path:/tmp/pip-TtoRGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:04 INFO - Running setup.py (path:/tmp/pip-I1Qw4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:04 INFO - Running setup.py (path:/tmp/pip-5xOTwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:05 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)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:05 INFO - Running setup.py (path:/tmp/pip-ZtH_vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:05 INFO - Running setup.py (path:/tmp/pip-br_UK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:05 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)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:05 INFO - Running setup.py (path:/tmp/pip-g1e8AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:05 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)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:05 INFO - Running setup.py (path:/tmp/pip-C3xSwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:05 INFO - Running setup.py (path:/tmp/pip-a7rvx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:05 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)) 02:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:05 INFO - Running setup.py (path:/tmp/pip-SlXkz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:07 INFO - Downloading blessings-1.6.tar.gz 02:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:07 INFO - Installing collected packages: blessings 02:32:07 INFO - Running setup.py install for blessings 02:32:07 INFO - Successfully installed blessings 02:32:07 INFO - Cleaning up... 02:32:07 INFO - Return code: 0 02:32:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:07 INFO - Reading from file tmpfile_stdout 02:32:07 INFO - Current package versions: 02:32:07 INFO - argparse == 1.2.1 02:32:07 INFO - blessings == 1.6 02:32:07 INFO - blobuploader == 1.2.4 02:32:07 INFO - docopt == 0.6.1 02:32:07 INFO - functools32 == 3.2.3-2 02:32:07 INFO - jsonschema == 2.5.1 02:32:07 INFO - manifestparser == 1.1 02:32:07 INFO - mozInstall == 1.12 02:32:07 INFO - mozcrash == 1.0 02:32:07 INFO - mozdebug == 0.1 02:32:07 INFO - mozdevice == 0.50 02:32:07 INFO - mozfile == 1.2 02:32:07 INFO - mozhttpd == 0.7 02:32:07 INFO - mozinfo == 0.9 02:32:07 INFO - mozleak == 0.1 02:32:07 INFO - mozlog == 3.4 02:32:07 INFO - moznetwork == 0.27 02:32:07 INFO - mozprocess == 0.25 02:32:07 INFO - mozprofile == 0.28 02:32:07 INFO - mozrunner == 6.13 02:32:07 INFO - mozscreenshot == 0.1 02:32:07 INFO - mozsystemmonitor == 0.3 02:32:07 INFO - moztest == 0.8 02:32:07 INFO - mozversion == 1.4 02:32:07 INFO - psutil == 3.1.1 02:32:07 INFO - requests == 1.2.3 02:32:07 INFO - wsgiref == 0.1.2 02:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:07 INFO - Using env: {'DISPLAY': ':0', 02:32:07 INFO - 'HOME': '/home/cltbld', 02:32:07 INFO - 'LANG': 'en_US.UTF-8', 02:32:07 INFO - 'LANGUAGE': 'en_US:en', 02:32:07 INFO - 'LOGNAME': 'cltbld', 02:32:07 INFO - 'MAIL': '/var/mail/cltbld', 02:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:07 INFO - 'MOZ_NO_REMOTE': '1', 02:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:07 INFO - 'NO_EM_RESTART': '1', 02:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:07 INFO - 'PWD': '/builds/slave/test', 02:32:07 INFO - 'SHELL': '/bin/bash', 02:32:07 INFO - 'SHLVL': '1', 02:32:07 INFO - 'TERM': 'linux', 02:32:07 INFO - 'TMOUT': '86400', 02:32:07 INFO - 'USER': 'cltbld', 02:32:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:07 INFO - '_': '/tools/buildbot/bin/python'} 02:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 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)) 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:08 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')]} 02:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:08 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')]} 02:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:08 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 0x1ee11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, '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': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', '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 02:32:08 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 02:32:08 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 02:32:08 INFO - Using env: {'DISPLAY': ':0', 02:32:08 INFO - 'HOME': '/home/cltbld', 02:32:08 INFO - 'LANG': 'en_US.UTF-8', 02:32:08 INFO - 'LANGUAGE': 'en_US:en', 02:32:08 INFO - 'LOGNAME': 'cltbld', 02:32:08 INFO - 'MAIL': '/var/mail/cltbld', 02:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:08 INFO - 'MOZ_NO_REMOTE': '1', 02:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:08 INFO - 'NO_EM_RESTART': '1', 02:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:08 INFO - 'PWD': '/builds/slave/test', 02:32:08 INFO - 'SHELL': '/bin/bash', 02:32:08 INFO - 'SHLVL': '1', 02:32:08 INFO - 'TERM': 'linux', 02:32:08 INFO - 'TMOUT': '86400', 02:32:08 INFO - 'USER': 'cltbld', 02:32:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:08 INFO - '_': '/tools/buildbot/bin/python'} 02:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Running post-action listener: _resource_record_post_action 02:32:08 INFO - Running post-action listener: _start_resource_monitoring 02:32:08 INFO - Starting resource monitoring. 02:32:08 INFO - [mozharness: 2017-04-11 09:32:08.465642Z] Finished create-virtualenv step (success) 02:32:08 INFO - [mozharness: 2017-04-11 09:32:08.466165Z] Running install step. 02:32:08 INFO - Running pre-action listener: _resource_record_pre_action 02:32:08 INFO - Running main action method: install 02:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:08 INFO - Reading from file tmpfile_stdout 02:32:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:08 INFO - Reading from file tmpfile_stdout 02:32:08 INFO - Output received: 02:32:08 INFO - Usage: mozinstall [options] installer 02:32:08 INFO - Options: 02:32:08 INFO - -h, --help show this help message and exit 02:32:08 INFO - -d DEST, --destination=DEST 02:32:08 INFO - Directory to install application into. [default: 02:32:08 INFO - "/builds/slave/test"] 02:32:08 INFO - --app=APP Application being installed. [default: firefox] 02:32:08 INFO - mkdir: /builds/slave/test/build/application 02:32:08 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'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:32:24 INFO - Reading from file tmpfile_stdout 02:32:24 INFO - Output received: 02:32:24 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:24 INFO - Running post-action listener: _resource_record_post_action 02:32:24 INFO - [mozharness: 2017-04-11 09:32:24.229490Z] Finished install step (success) 02:32:24 INFO - [mozharness: 2017-04-11 09:32:24.229739Z] Running run-tests step. 02:32:24 INFO - Running pre-action listener: _resource_record_pre_action 02:32:24 INFO - Running main action method: run_tests 02:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:24 INFO - Python 2.7.3 02:32:24 INFO - Return code: 0 02:32:24 INFO - grabbing minidump binary from tooltool 02:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217c290>, '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 0x217cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217d040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:32:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:32:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:32:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:24 INFO - Return code: 0 02:32:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:24 INFO - ENV: RUST_BACKTRACE is now 1 02:32:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 02:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 02:32:24 INFO - Using env: {'DISPLAY': ':0', 02:32:24 INFO - 'HOME': '/home/cltbld', 02:32:24 INFO - 'LANG': 'en_US.UTF-8', 02:32:24 INFO - 'LANGUAGE': 'en_US:en', 02:32:24 INFO - 'LOGNAME': 'cltbld', 02:32:24 INFO - 'MAIL': '/var/mail/cltbld', 02:32:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:24 INFO - 'MOZ_NO_REMOTE': '1', 02:32:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:24 INFO - 'NO_EM_RESTART': '1', 02:32:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:24 INFO - 'PWD': '/builds/slave/test', 02:32:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:24 INFO - 'RUST_BACKTRACE': '1', 02:32:24 INFO - 'SHELL': '/bin/bash', 02:32:24 INFO - 'SHLVL': '1', 02:32:24 INFO - 'TERM': 'linux', 02:32:24 INFO - 'TMOUT': '86400', 02:32:24 INFO - 'USER': 'cltbld', 02:32:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952', 02:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:24 INFO - '_': '/tools/buildbot/bin/python'} 02:32:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 02:32:24 INFO - mozversion application_buildid: 20170411090043 02:32:24 INFO - mozversion application_changeset: 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 02:32:24 INFO - mozversion application_display_name: Nightly 02:32:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:24 INFO - mozversion application_name: Firefox 02:32:24 INFO - mozversion application_remotingname: firefox 02:32:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:32:24 INFO - mozversion application_vendor: Mozilla 02:32:24 INFO - mozversion application_version: 55.0a1 02:32:24 INFO - mozversion platform_buildid: 20170411090043 02:32:24 INFO - mozversion platform_changeset: 830c7fcc3e73bc4b70b4cf1fbc5fed31b20d0a12 02:32:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:32:24 INFO - mozversion platform_version: 55.0a1 02:32:24 INFO - using testdate: 1491903144 02:32:24 INFO - actual date: 1491903144 02:32:24 INFO - starting webserver on 'localhost:35390' 02:32:24 INFO - SUITE-START | Running 2 tests 02:32:24 INFO - TEST-START | dromaeo_css 02:32:24 INFO - operating with platform_type : linux_ 02:32:24 INFO - Initialising browser for dromaeo_css test... 02:32:24 INFO - TEST-INFO | started process 388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxBiWHW/profile http://localhost:35390/getInfo.html) 02:32:29 INFO - PID 388 | __metrics Screen width/height:1600/1200 02:32:29 INFO - PID 388 | colorDepth:24 02:32:29 INFO - PID 388 | Browser inner width/height: 1024/697 02:32:29 INFO - PID 388 | __metrics 02:32:30 INFO - PID 388 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:32:30 INFO - PID 388 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:31 INFO - TEST-INFO | 388: exit 0 02:32:31 INFO - Browser initialized. 02:32:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:31 INFO - TEST-INFO | started process 486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxBiWHW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:43 INFO - PID 486 | RSS: Main: 153952256 02:32:43 INFO - PID 486 | 02:35:50 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35390/tests/dromaeo/cssquery-ext.html) 02:35:52 INFO - PID 486 | RSS: Main: 326963200 02:35:52 INFO - PID 486 | 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | A coding exception was thrown and uncaught in a Task. 02:37:32 INFO - PID 486 | 02:37:32 ERROR - PID 486 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:37:32 INFO - PID 486 | Full stack: 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | A coding exception was thrown and uncaught in a Task. 02:37:32 INFO - PID 486 | 02:37:32 ERROR - PID 486 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:37:32 INFO - PID 486 | Full stack: 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | A coding exception was thrown and uncaught in a Task. 02:37:32 INFO - PID 486 | 02:37:32 ERROR - PID 486 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:37:32 INFO - PID 486 | Full stack: 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | ************************* 02:37:32 INFO - PID 486 | A coding exception was thrown and uncaught in a Task. 02:37:32 INFO - PID 486 | 02:37:32 ERROR - PID 486 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:37:32 INFO - PID 486 | Full stack: 02:37:32 INFO - PID 486 | ************************* 02:38:54 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-ext.html (next: http://localhost:35390/tests/dromaeo/cssquery-jquery.html) 02:38:55 INFO - PID 486 | RSS: Main: 224935936 02:38:55 INFO - PID 486 | 02:41:57 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35390/tests/dromaeo/cssquery-mootools.html) 02:41:57 INFO - PID 486 | RSS: Main: 215502848 02:41:57 INFO - PID 486 | 02:44:59 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35390/tests/dromaeo/cssquery-prototype.html) 02:45:00 INFO - PID 486 | RSS: Main: 178786304 02:45:00 INFO - PID 486 | 02:48:03 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35390/tests/dromaeo/cssquery-yui.html) 02:48:04 INFO - PID 486 | RSS: Main: 186843136 02:48:04 INFO - PID 486 | 02:51:06 INFO - PID 486 | Cycle 1(1): loaded http://localhost:35390/tests/dromaeo/cssquery-yui.html (next: http://localhost:35390/tests/dromaeo/cssquery-dojo.html) 02:51:06 INFO - PID 486 | RSS: Main: 257818624 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | __start_tp_report 02:51:06 INFO - PID 486 | _x_x_mozilla_page_load 02:51:06 INFO - PID 486 | _x_x_mozilla_page_load_details 02:51:06 INFO - PID 486 | |i|pagename|runs| 02:51:06 INFO - PID 486 | |0;dojo.html;2642.5903984882343;2697.3930865555253;2712.213458097152;2718.9456210875783;2733.139061195723;5139.0749665060275;5224.320838291022;5232.189010703338;5255.343082114731;5265.7367131643405;5141.203113517401;5156.278121063054;5209.843704688866;5267.446918073604;5307.150855863063;4406.845760398387;4667.39323887895;4752.334673145745;4795.664303498756;4795.808167673289;4717.787699553511;4728.834490792823;4761.357216775743;4767.427908650967;4816.879578010543;4606.009707912782;4650.720956742606;4659.603933665642;4674.555917187896;4686.367340409035;4666.766661666903;4669.463011753658;4700.083483720676;4733.692309999839;4740.07568524138;4617.21507343749;4652.930206046912;4655.7439340836245;4672.415948006499;4688.109259240733;5075.340205773263;5143.614228932845;5194.71429071401;5211.7133557654315;5256.2904007959205;5623.831285061455;5640.294963129609;5651.434856514356;5651.547876169897;5657.462541058593;5674.8650269945765;5718.542516598662;5719.828405147852;5754.424557544254;5775.306963164448;5276.12943864262;5291.947080529222;5293.947060529345;5295.735213239323;5296.947030529645;5683;5765.798197063083;5769.249997500298;5771.653700777967;5774.682392468455;5493.176023596413;5525.11598144295;5534.4742249486235;5573.60984731073;5643.887122257532;5635.6618602883955;5637.46444087811;5640.041192997201;5642.605017648725;5680;5593.888122237614;5600.971995140079;5602.13166959122;5604.551635869121;5606.327240731139;5512.310961129859;5587.245721827582;5597.608167428241;5608.046632072557;5613.691246981373;4722.811087556459;4728.976355118202;4738.739369334719;4739.241721324572;4739.857804265877;4062.1672557125717;4063.674906007512;4085.142120154801;4095.651869591118;4098.016476045727;4813.975930120397;4814.542618451312;4817.735024573612;4819.49395313494;4859.65982381237;5594.552435805207;5656.123300888286;5667.943320566824;5717.17101020358;5718.857028574235;4760.428748550196;4786.353842231254;4842.128416884994;4844.515548445127;4854.417469903634;5048;5058.190689489664;5058.949410505921;5060.3927528696795;5105.132127538253;5302.549283310962;5313.628046036741;5314;5322.414534401135;5326.680399176062;5502.367227768697;5659.462351076641;5663.348714897839;5686.943130568641;5773.076307790733;5292.391374991926;5320.787168513216;5326.227696983993;5355.946440535545;5367.329083864517;5603.243562119062;5606.971965140148;5612.579056570855;5615.298087739033;5619.634723742944;5542.528885044816;5604.439556044363;5645.858853528694;5711.828645140652;5766.740496677576;5440.4015558287765;5456.045192091288;5456.781728730965;5458.317710286215;5459.4540545946675;5440.347158340866;5443.047466693392;5453;5455.618106732491;5494.890102197854;5468.316460442445;5470.234167216513;5476.342838859362;5494.148406996922;5521.282233309644;5570.582206334622;5577.191307260506;5579.302587176603;5580.5535557156145;5582.33012038558;5298.8940221196135;5376.919346209732;5386.245925570345;5424.566034717134;5470.261514695465 02:51:06 INFO - PID 486 | |1;ext.html;665.5008743442418;737.0197637142601;756.4062211164236;984.7636567223868;1012.0891197921865;26480.33799155022;32634.67365326346;33067.33865322695;33203;33268.33463330732;34391;34732.479012814765;34912.12719682009;34947.3010539789;34968.65031349686;7226.205117437091;7392.2238164992705;7393.630318484081;7398.408127349826;7400.111986561593;5511.311086114236;5651.604387692863;7086.539374940612;7254.746083887065;7268.454865885054;7305.817354566152;7384.52000619958;7387.815304617374;7389.187189409161;7393.112826460832;7302.671379787922;7359.374453171434;7364.1163060432555;7367.963160184165;7373.77878663641;7204.819879503002;7256.709731610729;7262.237465066145;7263.709451621929;7270.309320614533;32383.676163238302;32671.509927351108;32682;32755.6724432755;32763;3055.129288152888;3102.0073576455543;3106.6582675905634;3110.206897241189;3110.3934732727125;24519;24587.877060614763;24660.383490412703;24669.136580219605;24739;3235.4014507315987;3254.7233485153793;3277.131560136566;3277.96722032779;3283.9343213135844;135869;136814;137125.3143734285;137179;137315;40506.594934050874;40701.796491017354;40762;40794.77615671534;41125.38311925324;42498.78750606289;42615.14769704588;42931.35602965958;43012.56987430148;43168.352474712905;12575.496980120875;12706.110572260039;12715.427805748763;12720.045996550296;12720.045996550296;10215.23385746072;10217.846732299022;10222.182225421948;10229.590816367261;10230.028147325993;10434.895651043544;10561.155107591374;10582.153427725763;10673.35959842412;10698.839517407245;4410.140022695544;4842.612590992782;4943.604511639061;4944.53026962438;4986;903.1510380242551;905.3888625177979;925.7824411263348;927.4806108579218;928.3547934185812;20085.910993829406;20537.58924821495;20742.481437964172;21228.893855530623;21552.353429397142;1003.2225025605214;1008.7024327823164;1009.7778488732467;1013.159077965287;1013.6198925402974;10839.187060970458;11162.665120046411;11289.435528223721;11300.943495282636;11360.375179365048;181361;181456;181879;182773;183040;40279.3958090623;40412.59587404147;40424.79787601102;40464.59535404667;40484;1189.3140135879119;1237.3751255615857;1237.8947789437998;1238.8761123887539;1254.8243245945575;19661.705074423608;19768.09771242269;19779.604407912047;21023.789762102795;21163.25928592492;29724.70275297306;29900;29911.102666920026;29963.55054674138;29978.85010574933;174860;175222;175251;175529;175546;28895;29371.11886643404;29465.558016630195;29480.852595736884;29552;30100.54849177308;30424;36227;36326;36426.089347766516;25842;26004;26480.470390592465;26971.86514067417;27288.454230915668;26145.60781588316;26571;26674.866625666746;26700.332491687863;26740.05859355508;29455.705442945295;29515.37665428422;29616.703832962256;29632.851835740683;29638.259043524085;25228.117015904354;25863.073742932982;26168;26178.345541361618;27115.457690845677;20178.697319539926;21080;21088.66313206791;22254.554908902057;22914.65628015548 02:51:06 INFO - PID 486 | |2;jquery.html;412.128348542832;415.85237240779543;426.62030792594595;432.30614863144655;438.9626881715054;16763;17709.203085861136;18463.907680461594;18478.722819157723;19260.325888593903;17429;17638.11809409531;19054.33309834156;19538.804611953878;19722.802771972278;5716.1425786131995;5741.33974592923;5802.419758024185;5839.32847722511;5839.5620328475325;5786;5893.499052580536;5895;5896.204012458306;5897.4692277695;5661;5801.593888427812;5850.385709500505;5859.150423188635;5861.2087368205175;5547.583931205136;5770.278715160605;5812.796552120655;5829.591928565023;5830.679312637803;5213.452587478336;5247.921281180786;5250.159974404077;5250.212468129773;5250.947490525123;22722.091116355325;22872.65691014636;22874.085036598517;23380.18169364064;23541.764582354128;1709.2735587375316;1758.929642814286;1758.9384371547062;1760.0231871311416;1762.268658506718;14621.195834229113;14819.925900370537;15212.619684507865;15262.08427494354;15371.692566148726;2042.3974927396453;2116.2064225915283;2121.1197353098446;2121.5650791587686;2152.752433470155;69309.65345173293;88822.55588722079;89208.55395723044;90936;96191;10892.40091794959;11116.166287528467;11176.608818691308;11229.494672739584;11291.830622540505;15850.68298634044;15883.761743573856;15887.920560397355;15891.841081589037;15912.124833134289;7728.6522106505345;7798.961005194938;7927.682892684228;8134.511929284144;8139;7061.293870612898;7135.678894449762;7337.19290878003;7368.778936631909;7395.26047395267;6914.757983470555;7064.540804847668;7078.716851325992;7153.213146553875;7177.03110080143;1929.9614007719767;1941.65050290949;1972.161831221725;1995.2517805822818;2158.3093410108613;849.7790574450564;853.6073406233078;877.171098260122;900.7928176519306;908.4640062363237;17551.122443877754;17559.540029429274;17867.1959761811;18150.364737234133;18183.727244091348;894.4320356573493;895.7939673875045;896.6458248991612;903.4714691905309;927.4620719982394;9614.567344469515;9636.132748052709;9866.802663946824;10000.0999910007;10136.493175341204;488552;503055;507364;516169;523751;92207;95996.52001739947;96292.51853740687;98360.01639983652;98911;1076.3272954403499;1084.1706094837455;1134.812755895268;1141.6061458796703;1146.8875191064822;17821.1980460877;17976.820231797516;18378.081095945417;18571;18835.529111772314;43738;43916.12167756691;44235.77882110698;44309.55690443183;44470.55529444664;56516.43483565276;56976.43023569877;57235.42764572301;58056.4194358051;58211.12683309839;8478.279346255636;8586.398952073296;8660.220580147818;8684.65387864882;8843.60203790818;12477.376131193585;12614.55849045279;12760.905631885917;12878.227306361649;13164;10368.637097701545;10439.37363758177;10782.568697252022;10909.781804364027;11373.374464404536;9857.35927164732;10825.891741082489;10853.891461085288;10899.564017439214;10960.945195273973;10424.583016679551;10698.251122421667;11327.660170194908;11435.256708313933;11970.521179152736;8521.912131527815;8673.739787806124;8744.344174186834;8951.507667078113;9099.727008189764;10692.144628429862;11047;11116.388598627153;11137.777244455228;11210.719732006764 02:51:06 INFO - PID 486 | |3;mootools.html;1280.93595320234;1334.6263046347026;1343.4827591377323;1346.1519242876986;1350.291097173983;9803.901960980387;10246.74383140422;10250.231232657552;10258.281920265585;10260.127889129433;10084.092431681147;10295.588176472933;10573.048425641691;10644.733881652963;10645.78708425831;2223.188536184289;2255.954880902381;2271.1483193802324;2272.7727227277305;2277.6697378880053;1861.1438738180452;2180.498485348363;2255.0979608156704;2255.5827171973156;2274.8976296066717;1971.122850331603;2218.5673793610254;2288.382136823057;2300.2869110575775;2304.1474654377903;2196.791304826055;2256.7066281383395;2261.3216035189544;2265.275111964172;2266.61467550516;2228.053077442081;2242.3048854855047;2244.797968182855;2245.113180293775;2247.438140464884;10328.58685652573;10414.687559373231;10428.061474467258;10433.269671123024;10435.791284174275;5567.693776842272;5786.132080188006;5805.10020946754;5806.709664516758;5809.796657116981;3247.334296469242;3339.8664053437833;3407.7784943978563;3494.8427320770625;3515.244222492151;1176.1355403778216;1208.8428504294473;1219.231883913129;1274.120856608937;1274.993625031878;15292.923535382251;15412;15446.227688615525;15449.073055616811;15450.613734656612;4659.277811939155;4920.852374428773;5055.974720126449;5078.044952693166;5095.87260318495;11429.485673144729;11430.485628146753;11434.199606027498;11438.370889601152;11441.771164576661;5730.971345143247;5734.684592347461;5735.254416925773;5740.913886291709;5741.712914354265;5217.7912883485;5264.289320941624;5343.519083282523;5406.648567843077;5460.863478413072;3821.7898015609408;3865.6520913117956;3976.5029371328583;3983.2830090583393;4008.218397412535;1082.3614067700096;1146.5929594993825;1146.810776221914;1163.33689796815;1185.5020891225706;623.2769986815363;657.1555551116792;724.2069933422894;738.8633102875986;745.7650839985496;5878.941210587839;5925.585209035412;5950.761969521257;5971.104334349882;6180.443760061616;833.4957350802677;868.700298397052;879.4020066354813;892.2727976698969;897.7800438892383;3622.221222437136;3655.6527129922615;3716.2567486502808;3833.041739565109;3868.2843673920415;12927.676808079874;13593.116447430886;13942.58172254834;13984.930075349761;13990.790138147935;13799.379027943767;14012.369443375073;14078.577642670736;14082.155070695791;14086.295685215904;9438.622455101719;9701.9029809701;9758.365706229073;9760.219182465386;9766.706998790047;6315.684215789284;6401.231852177769;6403.167588213502;6430.967845160932;6446.09754634361;12048.939755301168;12131.939340303243;12149.724278950584;12286.201396909173;12318.076144289034;12215.938920305342;12290.938545307215;12331.136820422484;12362.567310144103;12374.257544547356;8322.50064996102;8418.579071046546;8495.660173593235;8503.447275927045;8504.574771261536;9585.760355991157;9689.079537444213;9777.364471309342;9785.706428807147;9791.902080979098;7944.563049032358;7979.720709775363;8168.3465322772845;8176.7955801105445;8187.385946053951;7929.722459713882;7962.840743184988;8052.355811534946;8120.512769233865;8121.878171827309;7301.63491825396;7321.816954576178;7373.483856130019;7380;7383.741569045058;5118.897622047463;5178.792848286026;5242.082635538842;5372.2747429098135;5385;5283.894322113613;5405.459454054563;5431.782728690808;5549.195366671891;5590.636608620427 02:51:06 INFO - PID 486 | |4;prototype.html;392.5074032089727;395.7961649750379;395.96238357356077;397.33446477150767;400.69747340757743;5163.48365163484;5234.293370394996;5254.18560123181;5258.211268309756;5283.286756287905;4953.752312384376;5053.787091098137;5062.645614806956;5146.5625421839095;5151.922721159186;4079.4492743479545;4086.9386959195563;4088.3000884199696;4096.160287141129;4139.172165566883;4064;4101.876943691694;4103.240900433414;4106.568810274923;4107.500762221783;3805.543334799828;4076.4496792932873;4087.12126892718;4092.4270602115726;4096.303628383167;3962.9009274768073;3970.166265084336;3988.78061706606;3997.120633460634;4011.518617765872;3514.701250393694;3515.8769443069627;3519.384107781128;3519.8592056317716;3524.1189702574356;5010.799568017275;5015.423226328982;5047.192449208146;5058.949410505921;5063.291139240509;4480.686351955364;4656.4877863434995;4679.906401871977;4680.765961701902;4690.226112691402;5492.340919089735;5500.42245564218;5508.017113839015;5518.144687573393;5531.170324451365;3926.1362500249897;3935.193285376491;3953.723239373245;3956.208758248333;3961.504811898513;5635.71821408932;5706.828795136153;5804.854878627983;5805.477507024346;5809.7676092956235;3999.1801680655394;4009.4787677601726;4025.7383270087935;4041.1109555897656;4042.2723909696538;4072.857449989236;4085.754854708727;4099.569545197771;4104.4048612950955;4105.67154627629;4544.909101817945;4638.930416043762;4675.99466114787;4687.671862969628;4697.365855609517;5500.779968801283;5512.255845460892;5515.172724091419;5517.2551705519245;5522.751476183581;1392.853750356198;1411.6682579593787;1414.476643641859;1416.3767942105442;1418.7942748301646;904.5658084119659;960.8030353777459;965.0879918476971;972.0085512776928;978.256525040974;4841.886366135808;4852.199387101159;4859.586935110485;4868.245421959602;4870.805167793249;5722.914156287659;5727.083666613322;5754.223179870748;5765.625234359753;5780.6820624865195;4604.447466303998;4823.421189457217;4831.589314908272;4863.392075990501;4873.171560834667;2963.4221326841057;2982.4035192961496;2987.4025194961096;2998.8950386736797;3029.2578318312153;5316.680999140064;5344.4922732340365;5346.385165705916;5366.409694933554;5368.114261146867;5616.21373007771;5621;5771.653700777967;5834.854128646818;5860.38465961068;5215.739213039333;5313.256144139824;5320.441353657888;5332.813351532678;5342.6260161788305;5709.885802283848;5731.283589551306;5739.282589676291;5739.942600573941;5752.741126649227;5432.565394768488;5632.324121105494;5668.829935101953;5671.291088613923;5694.117411801178;5332.746804500862;5365.731713414391;5381.19282107687;5387.3804512481565;5399.244105825109;4037.9596204038758;4038.91922161561;4047.453593764922;4050.10897602527;4060.878173654795;5541.307336582927;5744.684042377709;5772.797952071657;5804.361520232686;5807.332156802022;5560.91562145394;5575.8606034847835;5591.958934988781;5594.41258667834;5602.719864006865;5381.327334083239;5586.636868603528;5592.69240191777;5596.720163991866;5618.3425889361915;5484.753186106555;5504.091824849015;5508.173773933942;5510.614257002132;5518.255035570307;5586.217929489956;5596.468335508121;5599.468050535193;5623.325200975745;5630.380658127685;5346.679199247902;5417.997670430983;5424;5451.754671039734;5463.7814487420055 02:51:06 INFO - PID 486 | |5;yui.html;660.8380946668067;766.1036587192983;778.5017588743206;778.8325510015345;792.2354927494966;11144.21990460667;15131.546053618395;15699.843001569981;15864.682706345866;15902.363905443797;14811.407543698238;15667.686646267068;15830;15842.683146337067;15867.127307998055;908.3051465628799;923.8429466990627;931.1433481197281;931.3015238571072;933.8039011807529;580.422479632766;595.9672218028006;886.2289807867132;912.0605776050678;912.9224015958652;963.9807203855919;964.4984608003869;965.4496936746058;965.5268918230087;965.8261512927705;957.492528959649;958.4393130018947;959.712086374092;960.7646126698934;960.8414611589079;468.03818153694147;473.6968340262235;672.8418821576926;692.2489099327236;706.523096909584;14161.504347347896;14191.077579957373;14214.644633884132;14272.571822845332;14284.428622855074;15072.773908391382;15957.601059973478;16082.276297566521;16144.192790360436;16146.354145834153;12064;12436.502539898393;12536.498540058477;12565.685857853536;12570.874291257152;2593.701724301711;2594.299539124445;2599.5970624553224;2615.045508389443;2615.424606586567;64377;65197.348026519605;66830;67151;68544.6572767138;10315.226358023177;10576.735581610521;10581.523831427605;10725.410102444284;10752.838707419394;19001.619967600847;19091.904540477208;19560.608787824163;19660.410187694393;20618.896905515376;6996.160460744743;7261;7299.270072992658;7343.963280183565;7352.96323518379;3566.8751593694096;3615.060084378028;3634.509341238952;3636.9636303637153;3640.4357324614725;3487.89536313911;3639.6724294813066;3639.79981101042;3646.197836475971;3656.0494271489606;710.5665544018145;733.2484203691259;734.5372415378278;738.4129616954534;740.6629983357667;612.8253447767365;619.1363048547252;625.6902833097555;635.7488791927162;640.0399400898652;9648.9956667982;9676.612935482643;9835.21318294549;9896.752581185528;10231.181505479544;597.4324391827781;606.5390303369471;611.9938800611936;616.3098817995054;621.5152181298595;4473.6868419211;4514.706544074625;4528.547145285445;4534.750588717587;4555.339475775994;58729.119063214086;58865;59667;64446.35553644403;65233;52119.73940130351;52690.47309526932;53046;53456.19815702768;53733.46266537363;46622;46843;47032.7648361756;48261.276080858814;48791.51208487941;9818.36180648284;9928.305018648625;10063.899361006297;10091.091801737879;10464.529096190841;25622.103226386986;25945;26386.07648732285;26613.467730645665;27052.864735676194;32507.410313956967;32740.181495462803;32888.342233154726;33324.500132497546;33451.665483344856;12085.154039217523;12144.817827732768;12172.087093468203;12255.387230638611;12256.87743122593;15103.47137850214;15138.167400793061;15240.847591523943;15312.38750450014;15328.770068449205;13258.680624924866;13505.39225734864;13580.185188888698;13706.24615646149;13818.516351927634;12775.23348599087;12933.935330323287;12997.285149316878;13097.934510327388;13184.60446186616;13173.47306107745;13366.131201471873;13373.331333433483;13414.865851341361;13527.188368697909;9589.664361747306;9975.650852220137;10176.287659863738;10185.33795303303;10484.790304194026;10460.63387781424;10701.036906678437;10928.50821713009;10955.452227388758;11167.609133680282 02:51:06 INFO - PID 486 | __end_tp_report 02:51:06 INFO - PID 486 | __start_cc_report 02:51:06 INFO - PID 486 | _x_x_mozilla_cycle_collect,1793 02:51:06 INFO - PID 486 | __end_cc_report 02:51:06 INFO - PID 486 | __startTimestamp1491904266638__endTimestamp 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | ------- Summary: start ------- 02:51:06 INFO - PID 486 | Number of tests: 6 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#0] dojo.html Cycles:165 Average:5173.04 Median:5326.23 stddev:605.33 (11.4%) stddev-sans-first:573.71 02:51:06 INFO - PID 486 | Values: 2642.6 2697.4 2712.2 2718.9 2733.1 5139.1 5224.3 5232.2 5255.3 5265.7 5141.2 5156.3 5209.8 5267.4 5307.2 4406.8 4667.4 4752.3 4795.7 4795.8 4717.8 4728.8 4761.4 4767.4 4816.9 4606.0 4650.7 4659.6 4674.6 4686.4 4666.8 4669.5 4700.1 4733.7 4740.1 4617.2 4652.9 4655.7 4672.4 4688.1 5075.3 5143.6 5194.7 5211.7 5256.3 5623.8 5640.3 5651.4 5651.5 5657.5 5674.9 5718.5 5719.8 5754.4 5775.3 5276.1 5291.9 5293.9 5295.7 5296.9 5683.0 5765.8 5769.2 5771.7 5774.7 5493.2 5525.1 5534.5 5573.6 5643.9 5635.7 5637.5 5640.0 5642.6 5680.0 5593.9 5601.0 5602.1 5604.6 5606.3 5512.3 5587.2 5597.6 5608.0 5613.7 4722.8 4729.0 4738.7 4739.2 4739.9 4062.2 4063.7 4085.1 4095.7 4098.0 4814.0 4814.5 4817.7 4819.5 4859.7 5594.6 5656.1 5667.9 5717.2 5718.9 4760.4 4786.4 4842.1 4844.5 4854.4 5048.0 5058.2 5058.9 5060.4 5105.1 5302.5 5313.6 5314.0 5322.4 5326.7 5502.4 5659.5 5663.3 5686.9 5773.1 5292.4 5320.8 5326.2 5355.9 5367.3 5603.2 5607.0 5612.6 5615.3 5619.6 5542.5 5604.4 5645.9 5711.8 5766.7 5440.4 5456.0 5456.8 5458.3 5459.5 5440.3 5443.0 5453.0 5455.6 5494.9 5468.3 5470.2 5476.3 5494.1 5521.3 5570.6 5577.2 5579.3 5580.6 5582.3 5298.9 5376.9 5386.2 5424.6 5470.3 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#1] ext.html Cycles:180 Average:30621.63 Median:29635.56 stddev:42900.02 (144.8%) stddev-sans-first:42961.40 02:51:06 INFO - PID 486 | Values: 665.5 737.0 756.4 984.8 1012.1 26480.3 32634.7 33067.3 33203.0 33268.3 34391.0 34732.5 34912.1 34947.3 34968.7 7226.2 7392.2 7393.6 7398.4 7400.1 5511.3 5651.6 7086.5 7254.7 7268.5 7305.8 7384.5 7387.8 7389.2 7393.1 7302.7 7359.4 7364.1 7368.0 7373.8 7204.8 7256.7 7262.2 7263.7 7270.3 32383.7 32671.5 32682.0 32755.7 32763.0 3055.1 3102.0 3106.7 3110.2 3110.4 24519.0 24587.9 24660.4 24669.1 24739.0 3235.4 3254.7 3277.1 3278.0 3283.9 135869.0 136814.0 137125.3 137179.0 137315.0 40506.6 40701.8 40762.0 40794.8 41125.4 42498.8 42615.1 42931.4 43012.6 43168.4 12575.5 12706.1 12715.4 12720.0 12720.0 10215.2 10217.8 10222.2 10229.6 10230.0 10434.9 10561.2 10582.2 10673.4 10698.8 4410.1 4842.6 4943.6 4944.5 4986.0 903.2 905.4 925.8 927.5 928.4 20085.9 20537.6 20742.5 21228.9 21552.4 1003.2 1008.7 1009.8 1013.2 1013.6 10839.2 11162.7 11289.4 11300.9 11360.4 181361.0 181456.0 181879.0 182773.0 183040.0 40279.4 40412.6 40424.8 40464.6 40484.0 1189.3 1237.4 1237.9 1238.9 1254.8 19661.7 19768.1 19779.6 21023.8 21163.3 29724.7 29900.0 29911.1 29963.6 29978.9 174860.0 175222.0 175251.0 175529.0 175546.0 28895.0 29371.1 29465.6 29480.9 29552.0 30100.5 30424.0 36227.0 36326.0 36426.1 25842.0 26004.0 26480.5 26971.9 27288.5 26145.6 26571.0 26674.9 26700.3 26740.1 29455.7 29515.4 29616.7 29632.9 29638.3 25228.1 25863.1 26168.0 26178.3 27115.5 20178.7 21080.0 21088.7 22254.6 22914.7 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#2] jquery.html Cycles:180 Average:29844.21 Median:22088.48 stddev:83864.14 (379.7%) stddev-sans-first:84070.28 02:51:06 INFO - PID 486 | Values: 412.1 415.9 426.6 432.3 439.0 16763.0 17709.2 18463.9 18478.7 19260.3 17429.0 17638.1 19054.3 19538.8 19722.8 5716.1 5741.3 5802.4 5839.3 5839.6 5786.0 5893.5 5895.0 5896.2 5897.5 5661.0 5801.6 5850.4 5859.2 5861.2 5547.6 5770.3 5812.8 5829.6 5830.7 5213.5 5247.9 5250.2 5250.2 5250.9 22722.1 22872.7 22874.1 23380.2 23541.8 1709.3 1758.9 1758.9 1760.0 1762.3 14621.2 14819.9 15212.6 15262.1 15371.7 2042.4 2116.2 2121.1 2121.6 2152.8 69309.7 88822.6 89208.6 90936.0 96191.0 10892.4 11116.2 11176.6 11229.5 11291.8 15850.7 15883.8 15887.9 15891.8 15912.1 7728.7 7799.0 7927.7 8134.5 8139.0 7061.3 7135.7 7337.2 7368.8 7395.3 6914.8 7064.5 7078.7 7153.2 7177.0 1930.0 1941.7 1972.2 1995.3 2158.3 849.8 853.6 877.2 900.8 908.5 17551.1 17559.5 17867.2 18150.4 18183.7 894.4 895.8 896.6 903.5 927.5 9614.6 9636.1 9866.8 10000.1 10136.5 488552.0 503055.0 507364.0 516169.0 523751.0 92207.0 95996.5 96292.5 98360.0 98911.0 1076.3 1084.2 1134.8 1141.6 1146.9 17821.2 17976.8 18378.1 18571.0 18835.5 43738.0 43916.1 44235.8 44309.6 44470.6 56516.4 56976.4 57235.4 58056.4 58211.1 8478.3 8586.4 8660.2 8684.7 8843.6 12477.4 12614.6 12760.9 12878.2 13164.0 10368.6 10439.4 10782.6 10909.8 11373.4 9857.4 10825.9 10853.9 10899.6 10960.9 10424.6 10698.3 11327.7 11435.3 11970.5 8521.9 8673.7 8744.3 8951.5 9099.7 10692.1 11047.0 11116.4 11137.8 11210.7 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#3] mootools.html Cycles:180 Average:6493.78 Median:3685.95 stddev:4175.31 (113.3%) stddev-sans-first:4168.65 02:51:06 INFO - PID 486 | Values: 1280.9 1334.6 1343.5 1346.2 1350.3 9803.9 10246.7 10250.2 10258.3 10260.1 10084.1 10295.6 10573.0 10644.7 10645.8 2223.2 2256.0 2271.1 2272.8 2277.7 1861.1 2180.5 2255.1 2255.6 2274.9 1971.1 2218.6 2288.4 2300.3 2304.1 2196.8 2256.7 2261.3 2265.3 2266.6 2228.1 2242.3 2244.8 2245.1 2247.4 10328.6 10414.7 10428.1 10433.3 10435.8 5567.7 5786.1 5805.1 5806.7 5809.8 3247.3 3339.9 3407.8 3494.8 3515.2 1176.1 1208.8 1219.2 1274.1 1275.0 15292.9 15412.0 15446.2 15449.1 15450.6 4659.3 4920.9 5056.0 5078.0 5095.9 11429.5 11430.5 11434.2 11438.4 11441.8 5731.0 5734.7 5735.3 5740.9 5741.7 5217.8 5264.3 5343.5 5406.6 5460.9 3821.8 3865.7 3976.5 3983.3 4008.2 1082.4 1146.6 1146.8 1163.3 1185.5 623.3 657.2 724.2 738.9 745.8 5878.9 5925.6 5950.8 5971.1 6180.4 833.5 868.7 879.4 892.3 897.8 3622.2 3655.7 3716.3 3833.0 3868.3 12927.7 13593.1 13942.6 13984.9 13990.8 13799.4 14012.4 14078.6 14082.2 14086.3 9438.6 9701.9 9758.4 9760.2 9766.7 6315.7 6401.2 6403.2 6431.0 6446.1 12048.9 12131.9 12149.7 12286.2 12318.1 12215.9 12290.9 12331.1 12362.6 12374.3 8322.5 8418.6 8495.7 8503.4 8504.6 9585.8 9689.1 9777.4 9785.7 9791.9 7944.6 7979.7 8168.3 8176.8 8187.4 7929.7 7962.8 8052.4 8120.5 8121.9 7301.6 7321.8 7373.5 7380.0 7383.7 5118.9 5178.8 5242.1 5372.3 5385.0 5283.9 5405.5 5431.8 5549.2 5590.6 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#4] prototype.html Cycles:180 Average:4581.93 Median:5189.61 stddev:1333.79 (25.7%) stddev-sans-first:1299.94 02:51:06 INFO - PID 486 | Values: 392.5 395.8 396.0 397.3 400.7 5163.5 5234.3 5254.2 5258.2 5283.3 4953.8 5053.8 5062.6 5146.6 5151.9 4079.4 4086.9 4088.3 4096.2 4139.2 4064.0 4101.9 4103.2 4106.6 4107.5 3805.5 4076.4 4087.1 4092.4 4096.3 3962.9 3970.2 3988.8 3997.1 4011.5 3514.7 3515.9 3519.4 3519.9 3524.1 5010.8 5015.4 5047.2 5058.9 5063.3 4480.7 4656.5 4679.9 4680.8 4690.2 5492.3 5500.4 5508.0 5518.1 5531.2 3926.1 3935.2 3953.7 3956.2 3961.5 5635.7 5706.8 5804.9 5805.5 5809.8 3999.2 4009.5 4025.7 4041.1 4042.3 4072.9 4085.8 4099.6 4104.4 4105.7 4544.9 4638.9 4676.0 4687.7 4697.4 5500.8 5512.3 5515.2 5517.3 5522.8 1392.9 1411.7 1414.5 1416.4 1418.8 904.6 960.8 965.1 972.0 978.3 4841.9 4852.2 4859.6 4868.2 4870.8 5722.9 5727.1 5754.2 5765.6 5780.7 4604.4 4823.4 4831.6 4863.4 4873.2 2963.4 2982.4 2987.4 2998.9 3029.3 5316.7 5344.5 5346.4 5366.4 5368.1 5616.2 5621.0 5771.7 5834.9 5860.4 5215.7 5313.3 5320.4 5332.8 5342.6 5709.9 5731.3 5739.3 5739.9 5752.7 5432.6 5632.3 5668.8 5671.3 5694.1 5332.7 5365.7 5381.2 5387.4 5399.2 4038.0 4038.9 4047.5 4050.1 4060.9 5541.3 5744.7 5772.8 5804.4 5807.3 5560.9 5575.9 5592.0 5594.4 5602.7 5381.3 5586.6 5592.7 5596.7 5618.3 5484.8 5504.1 5508.2 5510.6 5518.3 5586.2 5596.5 5599.5 5623.3 5630.4 5346.7 5418.0 5424.0 5451.8 5463.8 02:51:06 INFO - PID 486 | 02:51:06 INFO - PID 486 | [#5] yui.html Cycles:180 Average:14652.01 Median:3635.74 stddev:16981.10 (467.1%) stddev-sans-first:16996.23 02:51:06 INFO - PID 486 | Values: 660.8 766.1 778.5 778.8 792.2 11144.2 15131.5 15699.8 15864.7 15902.4 14811.4 15667.7 15830.0 15842.7 15867.1 908.3 923.8 931.1 931.3 933.8 580.4 596.0 886.2 912.1 912.9 964.0 964.5 965.4 965.5 965.8 957.5 958.4 959.7 960.8 960.8 468.0 473.7 672.8 692.2 706.5 14161.5 14191.1 14214.6 14272.6 14284.4 15072.8 15957.6 16082.3 16144.2 16146.4 12064.0 12436.5 12536.5 12565.7 12570.9 2593.7 2594.3 2599.6 2615.0 2615.4 64377.0 65197.3 66830.0 67151.0 68544.7 10315.2 10576.7 10581.5 10725.4 10752.8 19001.6 19091.9 19560.6 19660.4 20618.9 6996.2 7261.0 7299.3 7344.0 7353.0 3566.9 3615.1 3634.5 3637.0 3640.4 3487.9 3639.7 3639.8 3646.2 3656.0 710.6 733.2 734.5 738.4 740.7 612.8 619.1 625.7 635.7 640.0 9649.0 9676.6 9835.2 9896.8 10231.2 597.4 606.5 612.0 616.3 621.5 4473.7 4514.7 4528.5 4534.8 4555.3 58729.1 58865.0 59667.0 64446.4 65233.0 52119.7 52690.5 53046.0 53456.2 53733.5 46622.0 46843.0 47032.8 48261.3 48791.5 9818.4 9928.3 10063.9 10091.1 10464.5 25622.1 25945.0 26386.1 26613.5 27052.9 32507.4 32740.2 32888.3 33324.5 33451.7 12085.2 12144.8 12172.1 12255.4 12256.9 15103.5 15138.2 15240.8 15312.4 15328.8 13258.7 13505.4 13580.2 13706.2 13818.5 12775.2 12933.9 12997.3 13097.9 13184.6 13173.5 13366.1 13373.3 13414.9 13527.2 9589.7 9975.7 10176.3 10185.3 10484.8 10460.6 10701.0 10928.5 10955.5 11167.6 02:51:06 INFO - PID 486 | -------- Summary: end -------- 02:51:06 INFO - PID 486 | 02:51:07 INFO - TEST-INFO | 486: exit 0 02:51:07 INFO - TEST-OK | dromaeo_css | took 1123003ms 02:51:07 INFO - TEST-START | kraken 02:51:07 INFO - operating with platform_type : linux_ 02:51:07 INFO - Initialising browser for kraken test... 02:51:07 INFO - TEST-INFO | started process 818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXbjCL/profile http://localhost:35390/getInfo.html) 02:51:12 INFO - PID 818 | __metrics Screen width/height:1600/1200 02:51:12 INFO - PID 818 | colorDepth:24 02:51:12 INFO - PID 818 | Browser inner width/height: 1024/697 02:51:12 INFO - PID 818 | __metrics 02:51:13 INFO - PID 818 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:51:13 INFO - PID 818 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:14 INFO - TEST-INFO | 818: exit 0 02:51:14 INFO - Browser initialized. 02:51:14 INFO - Running cycle 1/1 for kraken test... 02:51:14 INFO - TEST-INFO | started process 920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXbjCL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:26 INFO - PID 920 | RSS: Main: 154345472 02:51:26 INFO - PID 920 | 02:51:29 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35390/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:30 INFO - PID 920 | RSS: Main: 209068032 02:51:30 INFO - PID 920 | 02:51:32 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35390/tests/kraken/driver.html?testName=audio-dft) 02:51:33 INFO - PID 920 | RSS: Main: 188710912 02:51:33 INFO - PID 920 | 02:51:36 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35390/tests/kraken/driver.html?testName=audio-fft) 02:51:37 INFO - PID 920 | RSS: Main: 271048704 02:51:37 INFO - PID 920 | 02:51:39 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35390/tests/kraken/driver.html?testName=audio-oscillator) 02:51:40 INFO - PID 920 | RSS: Main: 180662272 02:51:40 INFO - PID 920 | 02:51:42 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35390/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:42 INFO - PID 920 | RSS: Main: 184774656 02:51:42 INFO - PID 920 | 02:51:46 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35390/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:46 INFO - PID 920 | RSS: Main: 224047104 02:51:46 INFO - PID 920 | 02:51:50 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35390/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:50 INFO - PID 920 | RSS: Main: 219172864 02:51:50 INFO - PID 920 | 02:51:53 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35390/tests/kraken/driver.html?testName=json-parse-financial) 02:51:54 INFO - PID 920 | RSS: Main: 220901376 02:51:54 INFO - PID 920 | 02:51:56 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35390/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:56 INFO - PID 920 | RSS: Main: 184643584 02:51:56 INFO - PID 920 | 02:51:58 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:59 INFO - PID 920 | RSS: Main: 192450560 02:51:59 INFO - PID 920 | 02:52:01 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:01 INFO - PID 920 | RSS: Main: 201015296 02:52:01 INFO - PID 920 | 02:52:04 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:05 INFO - PID 920 | RSS: Main: 204808192 02:52:05 INFO - PID 920 | 02:52:08 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:09 INFO - PID 920 | RSS: Main: 206266368 02:52:09 INFO - PID 920 | 02:52:11 INFO - PID 920 | Cycle 1(1): loaded http://localhost:35390/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35390/tests/kraken/driver.html?testName=ai-astar) 02:52:11 INFO - PID 920 | RSS: Main: 274923520 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | __start_tp_report 02:52:11 INFO - PID 920 | _x_x_mozilla_page_load 02:52:11 INFO - PID 920 | _x_x_mozilla_page_load_details 02:52:11 INFO - PID 920 | |i|pagename|runs| 02:52:11 INFO - PID 920 | |0;ai-astar;105;111;110;110;109;110;110;110;110;110 02:52:11 INFO - PID 920 | |1;audio-beat-detection;154;130;124;175;128;128;124;128;157;125 02:52:11 INFO - PID 920 | |2;audio-dft;166;167;165;165;166;167;166;165;170;165 02:52:11 INFO - PID 920 | |3;audio-fft;77;77;76;109;78;77;76;75;92;78 02:52:11 INFO - PID 920 | |4;audio-oscillator;83;84;107;86;85;84;103;84;83;103 02:52:11 INFO - PID 920 | |5;imaging-gaussian-blur;113;114;113;114;114;114;114;114;114;114 02:52:11 INFO - PID 920 | |6;imaging-darkroom;151;150;151;150;150;149;149;150;150;150 02:52:11 INFO - PID 920 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;98 02:52:11 INFO - PID 920 | |8;json-parse-financial;54;53;52;54;55;55;55;54;54;55 02:52:11 INFO - PID 920 | |9;json-stringify-tinderbox;58;57;56;56;55;57;57;57;57;57 02:52:11 INFO - PID 920 | |10;stanford-crypto-aes;90;82;85;82;82;82;83;82;82;81 02:52:11 INFO - PID 920 | |11;stanford-crypto-ccm;143;137;139;143;140;136;139;137;228;139 02:52:11 INFO - PID 920 | |12;stanford-crypto-pbkdf2;185;196;196;194;198;192;196;198;197;198 02:52:11 INFO - PID 920 | |13;stanford-crypto-sha256-iterative;75;72;71;71;72;72;71;71;70;71 02:52:11 INFO - PID 920 | __end_tp_report 02:52:11 INFO - PID 920 | __start_cc_report 02:52:11 INFO - PID 920 | _x_x_mozilla_cycle_collect,1987 02:52:11 INFO - PID 920 | __end_cc_report 02:52:11 INFO - PID 920 | __startTimestamp1491904331385__endTimestamp 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | ------- Summary: start ------- 02:52:11 INFO - PID 920 | Number of tests: 14 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:0.50 02:52:11 INFO - PID 920 | Values: 105.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:129.00 stddev:17.97 (13.9%) stddev-sans-first:18.01 02:52:11 INFO - PID 920 | Values: 154.0 130.0 124.0 175.0 128.0 128.0 124.0 128.0 157.0 125.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 02:52:11 INFO - PID 920 | Values: 166.0 167.0 165.0 165.0 166.0 167.0 166.0 165.0 170.0 165.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#3] audio-fft Cycles:10 Average:81.50 Median:77.00 stddev:10.82 (14.1%) stddev-sans-first:11.36 02:52:11 INFO - PID 920 | Values: 77.0 77.0 76.0 109.0 78.0 77.0 76.0 75.0 92.0 78.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:9.85 (11.7%) stddev-sans-first:10.10 02:52:11 INFO - PID 920 | Values: 83.0 84.0 107.0 86.0 85.0 84.0 103.0 84.0 83.0 103.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:52:11 INFO - PID 920 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 02:52:11 INFO - PID 920 | Values: 151.0 150.0 151.0 150.0 150.0 149.0 149.0 150.0 150.0 150.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.10 (1.2%) stddev-sans-first:1.09 02:52:11 INFO - PID 920 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 98.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:0.99 (1.8%) stddev-sans-first:1.05 02:52:11 INFO - PID 920 | Values: 54.0 53.0 52.0 54.0 55.0 55.0 55.0 54.0 54.0 55.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 02:52:11 INFO - PID 920 | Values: 58.0 57.0 56.0 56.0 55.0 57.0 57.0 57.0 57.0 57.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:2.64 (3.2%) stddev-sans-first:1.12 02:52:11 INFO - PID 920 | Values: 90.0 82.0 85.0 82.0 82.0 82.0 83.0 82.0 82.0 81.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:139.50 stddev:28.17 (20.2%) stddev-sans-first:29.82 02:52:11 INFO - PID 920 | Values: 143.0 137.0 139.0 143.0 140.0 136.0 139.0 137.0 228.0 139.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:196.50 stddev:4.00 (2.0%) stddev-sans-first:2.03 02:52:11 INFO - PID 920 | Values: 185.0 196.0 196.0 194.0 198.0 192.0 196.0 198.0 197.0 198.0 02:52:11 INFO - PID 920 | 02:52:11 INFO - PID 920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:1.35 (1.9%) stddev-sans-first:0.67 02:52:11 INFO - PID 920 | Values: 75.0 72.0 71.0 71.0 72.0 72.0 71.0 71.0 70.0 71.0 02:52:11 INFO - PID 920 | -------- Summary: end -------- 02:52:11 INFO - PID 920 | 02:52:12 INFO - TEST-INFO | 920: exit 0 02:52:12 INFO - TEST-OK | kraken | took 65277ms 02:52:12 INFO - SUITE-END | took 1188s 02:52:13 INFO - Completed test suite (00:19:48) 02:52:13 INFO - javascript benchmark 02:52:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6742.948214009001, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.5903984882343, 2697.3930865555253, 2712.213458097152, 2718.9456210875783, 2733.139061195723, 5139.0749665060275, 5224.320838291022, 5232.189010703338, 5255.343082114731, 5265.7367131643405, 5141.203113517401, 5156.278121063054, 5209.843704688866, 5267.446918073604, 5307.150855863063, 4406.845760398387, 4667.39323887895, 4752.334673145745, 4795.664303498756, 4795.808167673289, 4717.787699553511, 4728.834490792823, 4761.357216775743, 4767.427908650967, 4816.879578010543, 4606.009707912782, 4650.720956742606, 4659.603933665642, 4674.555917187896, 4686.367340409035, 4666.766661666903, 4669.463011753658, 4700.083483720676, 4733.692309999839, 4740.07568524138, 4617.21507343749, 4652.930206046912, 4655.7439340836245, 4672.415948006499, 4688.109259240733, 5075.340205773263, 5143.614228932845, 5194.71429071401, 5211.7133557654315, 5256.2904007959205, 5623.831285061455, 5640.294963129609, 5651.434856514356, 5651.547876169897, 5657.462541058593, 5674.8650269945765, 5718.542516598662, 5719.828405147852, 5754.424557544254, 5775.306963164448, 5276.12943864262, 5291.947080529222, 5293.947060529345, 5295.735213239323, 5296.947030529645, 5683.0, 5765.798197063083, 5769.249997500298, 5771.653700777967, 5774.682392468455, 5493.176023596413, 5525.11598144295, 5534.4742249486235, 5573.60984731073, 5643.887122257532, 5635.6618602883955, 5637.46444087811, 5640.041192997201, 5642.605017648725, 5680.0, 5593.888122237614, 5600.971995140079, 5602.13166959122, 5604.551635869121, 5606.327240731139, 5512.310961129859, 5587.245721827582, 5597.608167428241, 5608.046632072557, 5613.691246981373, 4722.811087556459, 4728.976355118202, 4738.739369334719, 4739.241721324572, 4739.857804265877, 4062.1672557125717, 4063.674906007512, 4085.142120154801, 4095.651869591118, 4098.016476045727, 4813.975930120397, 4814.542618451312, 4817.735024573612, 4819.49395313494, 4859.65982381237, 5594.552435805207, 5656.123300888286, 5667.943320566824, 5717.17101020358, 5718.857028574235, 4760.428748550196, 4786.353842231254, 4842.128416884994, 4844.515548445127, 4854.417469903634, 5048.0, 5058.190689489664, 5058.949410505921, 5060.3927528696795, 5105.132127538253, 5302.549283310962, 5313.628046036741, 5314.0, 5322.414534401135, 5326.680399176062, 5502.367227768697, 5659.462351076641, 5663.348714897839, 5686.943130568641, 5773.076307790733, 5292.391374991926, 5320.787168513216, 5326.227696983993, 5355.946440535545, 5367.329083864517, 5603.243562119062, 5606.971965140148, 5612.579056570855, 5615.298087739033, 5619.634723742944, 5542.528885044816, 5604.439556044363, 5645.858853528694, 5711.828645140652, 5766.740496677576, 5440.4015558287765, 5456.045192091288, 5456.781728730965, 5458.317710286215, 5459.4540545946675, 5440.347158340866, 5443.047466693392, 5453.0, 5455.618106732491, 5494.890102197854, 5468.316460442445, 5470.234167216513, 5476.342838859362, 5494.148406996922, 5521.282233309644, 5570.582206334622, 5577.191307260506, 5579.302587176603, 5580.5535557156145, 5582.33012038558, 5298.8940221196135, 5376.919346209732, 5386.245925570345, 5424.566034717134, 5470.261514695465], "value": 5128.7761447514695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.5008743442418, 737.0197637142601, 756.4062211164236, 984.7636567223868, 1012.0891197921865, 26480.33799155022, 32634.67365326346, 33067.33865322695, 33203.0, 33268.33463330732, 34391.0, 34732.479012814765, 34912.12719682009, 34947.3010539789, 34968.65031349686, 7226.205117437091, 7392.2238164992705, 7393.630318484081, 7398.408127349826, 7400.111986561593, 5511.311086114236, 5651.604387692863, 7086.539374940612, 7254.746083887065, 7268.454865885054, 7305.817354566152, 7384.52000619958, 7387.815304617374, 7389.187189409161, 7393.112826460832, 7302.671379787922, 7359.374453171434, 7364.1163060432555, 7367.963160184165, 7373.77878663641, 7204.819879503002, 7256.709731610729, 7262.237465066145, 7263.709451621929, 7270.309320614533, 32383.676163238302, 32671.509927351108, 32682.0, 32755.6724432755, 32763.0, 3055.129288152888, 3102.0073576455543, 3106.6582675905634, 3110.206897241189, 3110.3934732727125, 24519.0, 24587.877060614763, 24660.383490412703, 24669.136580219605, 24739.0, 3235.4014507315987, 3254.7233485153793, 3277.131560136566, 3277.96722032779, 3283.9343213135844, 135869.0, 136814.0, 137125.3143734285, 137179.0, 137315.0, 40506.594934050874, 40701.796491017354, 40762.0, 40794.77615671534, 41125.38311925324, 42498.78750606289, 42615.14769704588, 42931.35602965958, 43012.56987430148, 43168.352474712905, 12575.496980120875, 12706.110572260039, 12715.427805748763, 12720.045996550296, 12720.045996550296, 10215.23385746072, 10217.846732299022, 10222.182225421948, 10229.590816367261, 10230.028147325993, 10434.895651043544, 10561.155107591374, 10582.153427725763, 10673.35959842412, 10698.839517407245, 4410.140022695544, 4842.612590992782, 4943.604511639061, 4944.53026962438, 4986.0, 903.1510380242551, 905.3888625177979, 925.7824411263348, 927.4806108579218, 928.3547934185812, 20085.910993829406, 20537.58924821495, 20742.481437964172, 21228.893855530623, 21552.353429397142, 1003.2225025605214, 1008.7024327823164, 1009.7778488732467, 1013.159077965287, 1013.6198925402974, 10839.187060970458, 11162.665120046411, 11289.435528223721, 11300.943495282636, 11360.375179365048, 181361.0, 181456.0, 181879.0, 182773.0, 183040.0, 40279.3958090623, 40412.59587404147, 40424.79787601102, 40464.59535404667, 40484.0, 1189.3140135879119, 1237.3751255615857, 1237.8947789437998, 1238.8761123887539, 1254.8243245945575, 19661.705074423608, 19768.09771242269, 19779.604407912047, 21023.789762102795, 21163.25928592492, 29724.70275297306, 29900.0, 29911.102666920026, 29963.55054674138, 29978.85010574933, 174860.0, 175222.0, 175251.0, 175529.0, 175546.0, 28895.0, 29371.11886643404, 29465.558016630195, 29480.852595736884, 29552.0, 30100.54849177308, 30424.0, 36227.0, 36326.0, 36426.089347766516, 25842.0, 26004.0, 26480.470390592465, 26971.86514067417, 27288.454230915668, 26145.60781588316, 26571.0, 26674.866625666746, 26700.332491687863, 26740.05859355508, 29455.705442945295, 29515.37665428422, 29616.703832962256, 29632.851835740683, 29638.259043524085, 25228.117015904354, 25863.073742932982, 26168.0, 26178.345541361618, 27115.457690845677, 20178.697319539926, 21080.0, 21088.66313206791, 22254.554908902057, 22914.65628015548], "value": 14433.195565792841, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.128348542832, 415.85237240779543, 426.62030792594595, 432.30614863144655, 438.9626881715054, 16763.0, 17709.203085861136, 18463.907680461594, 18478.722819157723, 19260.325888593903, 17429.0, 17638.11809409531, 19054.33309834156, 19538.804611953878, 19722.802771972278, 5716.1425786131995, 5741.33974592923, 5802.419758024185, 5839.32847722511, 5839.5620328475325, 5786.0, 5893.499052580536, 5895.0, 5896.204012458306, 5897.4692277695, 5661.0, 5801.593888427812, 5850.385709500505, 5859.150423188635, 5861.2087368205175, 5547.583931205136, 5770.278715160605, 5812.796552120655, 5829.591928565023, 5830.679312637803, 5213.452587478336, 5247.921281180786, 5250.159974404077, 5250.212468129773, 5250.947490525123, 22722.091116355325, 22872.65691014636, 22874.085036598517, 23380.18169364064, 23541.764582354128, 1709.2735587375316, 1758.929642814286, 1758.9384371547062, 1760.0231871311416, 1762.268658506718, 14621.195834229113, 14819.925900370537, 15212.619684507865, 15262.08427494354, 15371.692566148726, 2042.3974927396453, 2116.2064225915283, 2121.1197353098446, 2121.5650791587686, 2152.752433470155, 69309.65345173293, 88822.55588722079, 89208.55395723044, 90936.0, 96191.0, 10892.40091794959, 11116.166287528467, 11176.608818691308, 11229.494672739584, 11291.830622540505, 15850.68298634044, 15883.761743573856, 15887.920560397355, 15891.841081589037, 15912.124833134289, 7728.6522106505345, 7798.961005194938, 7927.682892684228, 8134.511929284144, 8139.0, 7061.293870612898, 7135.678894449762, 7337.19290878003, 7368.778936631909, 7395.26047395267, 6914.757983470555, 7064.540804847668, 7078.716851325992, 7153.213146553875, 7177.03110080143, 1929.9614007719767, 1941.65050290949, 1972.161831221725, 1995.2517805822818, 2158.3093410108613, 849.7790574450564, 853.6073406233078, 877.171098260122, 900.7928176519306, 908.4640062363237, 17551.122443877754, 17559.540029429274, 17867.1959761811, 18150.364737234133, 18183.727244091348, 894.4320356573493, 895.7939673875045, 896.6458248991612, 903.4714691905309, 927.4620719982394, 9614.567344469515, 9636.132748052709, 9866.802663946824, 10000.0999910007, 10136.493175341204, 488552.0, 503055.0, 507364.0, 516169.0, 523751.0, 92207.0, 95996.52001739947, 96292.51853740687, 98360.01639983652, 98911.0, 1076.3272954403499, 1084.1706094837455, 1134.812755895268, 1141.6061458796703, 1146.8875191064822, 17821.1980460877, 17976.820231797516, 18378.081095945417, 18571.0, 18835.529111772314, 43738.0, 43916.12167756691, 44235.77882110698, 44309.55690443183, 44470.55529444664, 56516.43483565276, 56976.43023569877, 57235.42764572301, 58056.4194358051, 58211.12683309839, 8478.279346255636, 8586.398952073296, 8660.220580147818, 8684.65387864882, 8843.60203790818, 12477.376131193585, 12614.55849045279, 12760.905631885917, 12878.227306361649, 13164.0, 10368.637097701545, 10439.37363758177, 10782.568697252022, 10909.781804364027, 11373.374464404536, 9857.35927164732, 10825.891741082489, 10853.891461085288, 10899.564017439214, 10960.945195273973, 10424.583016679551, 10698.251122421667, 11327.660170194908, 11435.256708313933, 11970.521179152736, 8521.912131527815, 8673.739787806124, 8744.344174186834, 8951.507667078113, 9099.727008189764, 10692.144628429862, 11047.0, 11116.388598627153, 11137.777244455228, 11210.719732006764], "value": 9280.22922348316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.93595320234, 1334.6263046347026, 1343.4827591377323, 1346.1519242876986, 1350.291097173983, 9803.901960980387, 10246.74383140422, 10250.231232657552, 10258.281920265585, 10260.127889129433, 10084.092431681147, 10295.588176472933, 10573.048425641691, 10644.733881652963, 10645.78708425831, 2223.188536184289, 2255.954880902381, 2271.1483193802324, 2272.7727227277305, 2277.6697378880053, 1861.1438738180452, 2180.498485348363, 2255.0979608156704, 2255.5827171973156, 2274.8976296066717, 1971.122850331603, 2218.5673793610254, 2288.382136823057, 2300.2869110575775, 2304.1474654377903, 2196.791304826055, 2256.7066281383395, 2261.3216035189544, 2265.275111964172, 2266.61467550516, 2228.053077442081, 2242.3048854855047, 2244.797968182855, 2245.113180293775, 2247.438140464884, 10328.58685652573, 10414.687559373231, 10428.061474467258, 10433.269671123024, 10435.791284174275, 5567.693776842272, 5786.132080188006, 5805.10020946754, 5806.709664516758, 5809.796657116981, 3247.334296469242, 3339.8664053437833, 3407.7784943978563, 3494.8427320770625, 3515.244222492151, 1176.1355403778216, 1208.8428504294473, 1219.231883913129, 1274.120856608937, 1274.993625031878, 15292.923535382251, 15412.0, 15446.227688615525, 15449.073055616811, 15450.613734656612, 4659.277811939155, 4920.852374428773, 5055.974720126449, 5078.044952693166, 5095.87260318495, 11429.485673144729, 11430.485628146753, 11434.199606027498, 11438.370889601152, 11441.771164576661, 5730.971345143247, 5734.684592347461, 5735.254416925773, 5740.913886291709, 5741.712914354265, 5217.7912883485, 5264.289320941624, 5343.519083282523, 5406.648567843077, 5460.863478413072, 3821.7898015609408, 3865.6520913117956, 3976.5029371328583, 3983.2830090583393, 4008.218397412535, 1082.3614067700096, 1146.5929594993825, 1146.810776221914, 1163.33689796815, 1185.5020891225706, 623.2769986815363, 657.1555551116792, 724.2069933422894, 738.8633102875986, 745.7650839985496, 5878.941210587839, 5925.585209035412, 5950.761969521257, 5971.104334349882, 6180.443760061616, 833.4957350802677, 868.700298397052, 879.4020066354813, 892.2727976698969, 897.7800438892383, 3622.221222437136, 3655.6527129922615, 3716.2567486502808, 3833.041739565109, 3868.2843673920415, 12927.676808079874, 13593.116447430886, 13942.58172254834, 13984.930075349761, 13990.790138147935, 13799.379027943767, 14012.369443375073, 14078.577642670736, 14082.155070695791, 14086.295685215904, 9438.622455101719, 9701.9029809701, 9758.365706229073, 9760.219182465386, 9766.706998790047, 6315.684215789284, 6401.231852177769, 6403.167588213502, 6430.967845160932, 6446.09754634361, 12048.939755301168, 12131.939340303243, 12149.724278950584, 12286.201396909173, 12318.076144289034, 12215.938920305342, 12290.938545307215, 12331.136820422484, 12362.567310144103, 12374.257544547356, 8322.50064996102, 8418.579071046546, 8495.660173593235, 8503.447275927045, 8504.574771261536, 9585.760355991157, 9689.079537444213, 9777.364471309342, 9785.706428807147, 9791.902080979098, 7944.563049032358, 7979.720709775363, 8168.3465322772845, 8176.7955801105445, 8187.385946053951, 7929.722459713882, 7962.840743184988, 8052.355811534946, 8120.512769233865, 8121.878171827309, 7301.63491825396, 7321.816954576178, 7373.483856130019, 7380.0, 7383.741569045058, 5118.897622047463, 5178.792848286026, 5242.082635538842, 5372.2747429098135, 5385.0, 5283.894322113613, 5405.459454054563, 5431.782728690808, 5549.195366671891, 5590.636608620427], "value": 4887.868030956724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5074032089727, 395.7961649750379, 395.96238357356077, 397.33446477150767, 400.69747340757743, 5163.48365163484, 5234.293370394996, 5254.18560123181, 5258.211268309756, 5283.286756287905, 4953.752312384376, 5053.787091098137, 5062.645614806956, 5146.5625421839095, 5151.922721159186, 4079.4492743479545, 4086.9386959195563, 4088.3000884199696, 4096.160287141129, 4139.172165566883, 4064.0, 4101.876943691694, 4103.240900433414, 4106.568810274923, 4107.500762221783, 3805.543334799828, 4076.4496792932873, 4087.12126892718, 4092.4270602115726, 4096.303628383167, 3962.9009274768073, 3970.166265084336, 3988.78061706606, 3997.120633460634, 4011.518617765872, 3514.701250393694, 3515.8769443069627, 3519.384107781128, 3519.8592056317716, 3524.1189702574356, 5010.799568017275, 5015.423226328982, 5047.192449208146, 5058.949410505921, 5063.291139240509, 4480.686351955364, 4656.4877863434995, 4679.906401871977, 4680.765961701902, 4690.226112691402, 5492.340919089735, 5500.42245564218, 5508.017113839015, 5518.144687573393, 5531.170324451365, 3926.1362500249897, 3935.193285376491, 3953.723239373245, 3956.208758248333, 3961.504811898513, 5635.71821408932, 5706.828795136153, 5804.854878627983, 5805.477507024346, 5809.7676092956235, 3999.1801680655394, 4009.4787677601726, 4025.7383270087935, 4041.1109555897656, 4042.2723909696538, 4072.857449989236, 4085.754854708727, 4099.569545197771, 4104.4048612950955, 4105.67154627629, 4544.909101817945, 4638.930416043762, 4675.99466114787, 4687.671862969628, 4697.365855609517, 5500.779968801283, 5512.255845460892, 5515.172724091419, 5517.2551705519245, 5522.751476183581, 1392.853750356198, 1411.6682579593787, 1414.476643641859, 1416.3767942105442, 1418.7942748301646, 904.5658084119659, 960.8030353777459, 965.0879918476971, 972.0085512776928, 978.256525040974, 4841.886366135808, 4852.199387101159, 4859.586935110485, 4868.245421959602, 4870.805167793249, 5722.914156287659, 5727.083666613322, 5754.223179870748, 5765.625234359753, 5780.6820624865195, 4604.447466303998, 4823.421189457217, 4831.589314908272, 4863.392075990501, 4873.171560834667, 2963.4221326841057, 2982.4035192961496, 2987.4025194961096, 2998.8950386736797, 3029.2578318312153, 5316.680999140064, 5344.4922732340365, 5346.385165705916, 5366.409694933554, 5368.114261146867, 5616.21373007771, 5621.0, 5771.653700777967, 5834.854128646818, 5860.38465961068, 5215.739213039333, 5313.256144139824, 5320.441353657888, 5332.813351532678, 5342.6260161788305, 5709.885802283848, 5731.283589551306, 5739.282589676291, 5739.942600573941, 5752.741126649227, 5432.565394768488, 5632.324121105494, 5668.829935101953, 5671.291088613923, 5694.117411801178, 5332.746804500862, 5365.731713414391, 5381.19282107687, 5387.3804512481565, 5399.244105825109, 4037.9596204038758, 4038.91922161561, 4047.453593764922, 4050.10897602527, 4060.878173654795, 5541.307336582927, 5744.684042377709, 5772.797952071657, 5804.361520232686, 5807.332156802022, 5560.91562145394, 5575.8606034847835, 5591.958934988781, 5594.41258667834, 5602.719864006865, 5381.327334083239, 5586.636868603528, 5592.69240191777, 5596.720163991866, 5618.3425889361915, 5484.753186106555, 5504.091824849015, 5508.173773933942, 5510.614257002132, 5518.255035570307, 5586.217929489956, 5596.468335508121, 5599.468050535193, 5623.325200975745, 5630.380658127685, 5346.679199247902, 5417.997670430983, 5424.0, 5451.754671039734, 5463.7814487420055], "value": 4178.649810404527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.8380946668067, 766.1036587192983, 778.5017588743206, 778.8325510015345, 792.2354927494966, 11144.21990460667, 15131.546053618395, 15699.843001569981, 15864.682706345866, 15902.363905443797, 14811.407543698238, 15667.686646267068, 15830.0, 15842.683146337067, 15867.127307998055, 908.3051465628799, 923.8429466990627, 931.1433481197281, 931.3015238571072, 933.8039011807529, 580.422479632766, 595.9672218028006, 886.2289807867132, 912.0605776050678, 912.9224015958652, 963.9807203855919, 964.4984608003869, 965.4496936746058, 965.5268918230087, 965.8261512927705, 957.492528959649, 958.4393130018947, 959.712086374092, 960.7646126698934, 960.8414611589079, 468.03818153694147, 473.6968340262235, 672.8418821576926, 692.2489099327236, 706.523096909584, 14161.504347347896, 14191.077579957373, 14214.644633884132, 14272.571822845332, 14284.428622855074, 15072.773908391382, 15957.601059973478, 16082.276297566521, 16144.192790360436, 16146.354145834153, 12064.0, 12436.502539898393, 12536.498540058477, 12565.685857853536, 12570.874291257152, 2593.701724301711, 2594.299539124445, 2599.5970624553224, 2615.045508389443, 2615.424606586567, 64377.0, 65197.348026519605, 66830.0, 67151.0, 68544.6572767138, 10315.226358023177, 10576.735581610521, 10581.523831427605, 10725.410102444284, 10752.838707419394, 19001.619967600847, 19091.904540477208, 19560.608787824163, 19660.410187694393, 20618.896905515376, 6996.160460744743, 7261.0, 7299.270072992658, 7343.963280183565, 7352.96323518379, 3566.8751593694096, 3615.060084378028, 3634.509341238952, 3636.9636303637153, 3640.4357324614725, 3487.89536313911, 3639.6724294813066, 3639.79981101042, 3646.197836475971, 3656.0494271489606, 710.5665544018145, 733.2484203691259, 734.5372415378278, 738.4129616954534, 740.6629983357667, 612.8253447767365, 619.1363048547252, 625.6902833097555, 635.7488791927162, 640.0399400898652, 9648.9956667982, 9676.612935482643, 9835.21318294549, 9896.752581185528, 10231.181505479544, 597.4324391827781, 606.5390303369471, 611.9938800611936, 616.3098817995054, 621.5152181298595, 4473.6868419211, 4514.706544074625, 4528.547145285445, 4534.750588717587, 4555.339475775994, 58729.119063214086, 58865.0, 59667.0, 64446.35553644403, 65233.0, 52119.73940130351, 52690.47309526932, 53046.0, 53456.19815702768, 53733.46266537363, 46622.0, 46843.0, 47032.7648361756, 48261.276080858814, 48791.51208487941, 9818.36180648284, 9928.305018648625, 10063.899361006297, 10091.091801737879, 10464.529096190841, 25622.103226386986, 25945.0, 26386.07648732285, 26613.467730645665, 27052.864735676194, 32507.410313956967, 32740.181495462803, 32888.342233154726, 33324.500132497546, 33451.665483344856, 12085.154039217523, 12144.817827732768, 12172.087093468203, 12255.387230638611, 12256.87743122593, 15103.47137850214, 15138.167400793061, 15240.847591523943, 15312.38750450014, 15328.770068449205, 13258.680624924866, 13505.39225734864, 13580.185188888698, 13706.24615646149, 13818.516351927634, 12775.23348599087, 12933.935330323287, 12997.285149316878, 13097.934510327388, 13184.60446186616, 13173.47306107745, 13366.131201471873, 13373.331333433483, 13414.865851341361, 13527.188368697909, 9589.664361747306, 9975.650852220137, 10176.287659863738, 10185.33795303303, 10484.790304194026, 10460.63387781424, 10701.036906678437, 10928.50821713009, 10955.452227388758, 11167.609133680282], "value": 6698.473174116068, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 124.0, 175.0, 128.0, 128.0, 124.0, 128.0, 157.0, 125.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 165.0, 165.0, 166.0, 167.0, 166.0, 165.0, 170.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 109.0, 78.0, 77.0, 76.0, 75.0, 92.0, 78.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 107.0, 86.0, 85.0, 84.0, 103.0, 84.0, 83.0, 103.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 56.0, 55.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 85.0, 82.0, 82.0, 82.0, 83.0, 82.0, 82.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 137.0, 139.0, 143.0, 140.0, 136.0, 139.0, 137.0, 228.0, 139.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 196.0, 196.0, 194.0, 198.0, 192.0, 196.0, 198.0, 197.0, 198.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 71.0, 71.0, 72.0, 72.0, 71.0, 71.0, 70.0, 71.0], "value": 71.6, "unit": "score"}]}]} 02:52:13 INFO - Return code: 0 02:52:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:13 ERROR - # TBPL SUCCESS # 02:52:13 INFO - Running post-action listener: _resource_record_post_action 02:52:13 INFO - [mozharness: 2017-04-11 09:52:13.171882Z] Finished run-tests step (success) 02:52:13 INFO - Running post-run listener: _resource_record_post_run 02:52:13 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363278336; Read time: 16; Write time: 331104 02:52:13 INFO - TinderboxPrint: CPU usage
13.0% 02:52:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:52:13 INFO - TinderboxPrint: I/O write bytes / time
363,278,336 / 331,104 02:52:13 INFO - TinderboxPrint: CPU idle
8,358.0 (87.0%) 02:52:13 INFO - TinderboxPrint: CPU user
1,202.3 (12.5%) 02:52:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109092864; Read time: 0; Write time: 98584 02:52:13 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254185472; Read time: 16; Write time: 232520 02:52:13 INFO - Running post-run listener: _upload_blobber_files 02:52:13 INFO - Blob upload gear active. 02:52:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:13 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:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:52:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:15 INFO - (blobuploader) - INFO - Done attempting. 02:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:15 INFO - (blobuploader) - INFO - Done attempting. 02:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:18 INFO - (blobuploader) - INFO - Done attempting. 02:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:19 INFO - (blobuploader) - INFO - Done attempting. 02:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:19 INFO - Return code: 0 02:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0be934a6d4996ec31147d85a40a2263cd16bdb3eee170738e1a11b16dc39b73f54c4ce684db95f0f424844b8866071a91cf74c1df1248f299fc2f5180994bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be40a095371a5d251e06830ea527bb6c5e411a55d31429f3074e3e677a9746e20f863a66cab3ebe986d3170b61499f6c8b383020dd6da181de10eec44919d2d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54d41d033a541f56d61b1c73b023c98c7252ff5699aae9434cb33c6f8eb263a17fbf7923f5da08101989640e3a64d9775287a942a7457c6045302fc8623d60f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af11bf3de93f0b09cff5f0fe33323bee7fee0aedcba25326117fca9984d9155cc24eae6f31bc8e73d3f7f18b3f883708db682d28d84fd7c4347e356b4bd7231"} 02:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:19 INFO - Contents: 02:52:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0be934a6d4996ec31147d85a40a2263cd16bdb3eee170738e1a11b16dc39b73f54c4ce684db95f0f424844b8866071a91cf74c1df1248f299fc2f5180994bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be40a095371a5d251e06830ea527bb6c5e411a55d31429f3074e3e677a9746e20f863a66cab3ebe986d3170b61499f6c8b383020dd6da181de10eec44919d2d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54d41d033a541f56d61b1c73b023c98c7252ff5699aae9434cb33c6f8eb263a17fbf7923f5da08101989640e3a64d9775287a942a7457c6045302fc8623d60f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af11bf3de93f0b09cff5f0fe33323bee7fee0aedcba25326117fca9984d9155cc24eae6f31bc8e73d3f7f18b3f883708db682d28d84fd7c4347e356b4bd7231"} 02:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:19 INFO - Copying logs to upload dir... 02:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.117272 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-11 02:52:18.721638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 02:52:18.726018) ========= 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=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0be934a6d4996ec31147d85a40a2263cd16bdb3eee170738e1a11b16dc39b73f54c4ce684db95f0f424844b8866071a91cf74c1df1248f299fc2f5180994bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be40a095371a5d251e06830ea527bb6c5e411a55d31429f3074e3e677a9746e20f863a66cab3ebe986d3170b61499f6c8b383020dd6da181de10eec44919d2d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54d41d033a541f56d61b1c73b023c98c7252ff5699aae9434cb33c6f8eb263a17fbf7923f5da08101989640e3a64d9775287a942a7457c6045302fc8623d60f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af11bf3de93f0b09cff5f0fe33323bee7fee0aedcba25326117fca9984d9155cc24eae6f31bc8e73d3f7f18b3f883708db682d28d84fd7c4347e356b4bd7231"} build_url:https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/G8XojSVKR6KoaiMmNIUe1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0be934a6d4996ec31147d85a40a2263cd16bdb3eee170738e1a11b16dc39b73f54c4ce684db95f0f424844b8866071a91cf74c1df1248f299fc2f5180994bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be40a095371a5d251e06830ea527bb6c5e411a55d31429f3074e3e677a9746e20f863a66cab3ebe986d3170b61499f6c8b383020dd6da181de10eec44919d2d", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54d41d033a541f56d61b1c73b023c98c7252ff5699aae9434cb33c6f8eb263a17fbf7923f5da08101989640e3a64d9775287a942a7457c6045302fc8623d60f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2af11bf3de93f0b09cff5f0fe33323bee7fee0aedcba25326117fca9984d9155cc24eae6f31bc8e73d3f7f18b3f883708db682d28d84fd7c4347e356b4bd7231"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 02:52:18.761249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:52:18.761642) ========= 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=920470bf432669ad7e3a5387000001ca-1491903075.304778-1166384952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:52:18.845995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 02:52:18.846351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 02:52:18.846711) ========= ========= Total master_lag: 0.19 =========