builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1490157701.99 results: success (0) revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:41.989427) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:41.989924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:41.990246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.004718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.004996) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 21:41:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2017-03-21 21:41:42 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.133404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.133924) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.185743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:42.186312) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 201231223cd4354a450c3e5d80959f35b8e4cf0c --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 201231223cd4354a450c3e5d80959f35b8e4cf0c --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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 21:41:42,705 truncating revision to first 12 chars 2017-03-21 21:41:42,705 Setting DEBUG logging. 2017-03-21 21:41:42,705 attempt 1/10 2017-03-21 21:41:42,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/201231223cd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 21:41:43,335 unpacking tar archive at: mozilla-central-201231223cd4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942953 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:43.143238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:43.143565) ========= script_repo_revision: 201231223cd4354a450c3e5d80959f35b8e4cf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:43.143955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:43.144230) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 21:41:43.151711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-21 21:41:43.151973) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:43 INFO - MultiFileLogger online at 20170321 21:41:43 in /builds/slave/test 21:41:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:41:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:43 INFO - {'append_to_log': False, 21:41:43 INFO - 'base_work_dir': '/builds/slave/test', 21:41:43 INFO - 'blob_upload_branch': 'Firefox', 21:41:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:43 INFO - 'branch': 'Firefox', 21:41:43 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:43 INFO - 'config_files': ('talos/linux_config.py',), 21:41:43 INFO - 'default_actions': ('clobber', 21:41:43 INFO - 'read-buildbot-config', 21:41:43 INFO - 'download-and-extract', 21:41:43 INFO - 'populate-webroot', 21:41:43 INFO - 'create-virtualenv', 21:41:43 INFO - 'install', 21:41:43 INFO - 'run-tests'), 21:41:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:43 INFO - 'download_minidump_stackwalk': True, 21:41:43 INFO - 'download_symbols': 'ondemand', 21:41:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:43 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:43 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:43 INFO - 'gecko_profile': False, 21:41:43 INFO - 'gecko_profile_interval': 0, 21:41:43 INFO - 'installer_path': 'installer.exe', 21:41:43 INFO - 'log_level': 'info', 21:41:43 INFO - 'log_name': 'talos', 21:41:43 INFO - 'log_to_console': True, 21:41:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:43 INFO - 'opt_config_files': (), 21:41:43 INFO - 'pip_index': False, 21:41:43 INFO - 'suite': 'dromaeojs', 21:41:43 INFO - 'system_bits': '32', 21:41:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:43 INFO - 'title': 'talos-linux64-ix-064', 21:41:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:43 INFO - 'use_talos_json': True, 21:41:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:43 INFO - 'work_dir': 'build'} 21:41:43 INFO - [mozharness: 2017-03-22 04:41:43.766691Z] Running clobber step. 21:41:43 INFO - Running pre-action listener: _resource_record_pre_action 21:41:43 INFO - Running main action method: clobber 21:41:43 INFO - rmtree: /builds/slave/test/build 21:41:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:45 INFO - Running post-action listener: _resource_record_post_action 21:41:45 INFO - [mozharness: 2017-03-22 04:41:45.222872Z] Finished clobber step (success) 21:41:45 INFO - [mozharness: 2017-03-22 04:41:45.222971Z] Running read-buildbot-config step. 21:41:45 INFO - Running pre-action listener: _resource_record_pre_action 21:41:45 INFO - Running main action method: read_buildbot_config 21:41:45 INFO - Using buildbot properties: 21:41:45 INFO - { 21:41:45 INFO - "project": "", 21:41:45 INFO - "product": "firefox", 21:41:45 INFO - "who": "philringnalda@gmail.com", 21:41:45 INFO - "installer_path": "public/build/target.tar.bz2", 21:41:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:41:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:41:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:41:45 INFO - "stage_platform": "linux64-pgo", 21:41:45 INFO - "basedir": "/builds/slave/test", 21:41:45 INFO - "buildnumber": 89, 21:41:45 INFO - "platform": "ubuntu64_hw", 21:41:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:41:45 INFO - "slavebuilddir": "test", 21:41:45 INFO - "taskId": "L_fvWOcCTUCryorZcujEaA", 21:41:45 INFO - "branch": "mozilla-central", 21:41:45 INFO - "script_repo_revision": "production", 21:41:45 INFO - "revision": "201231223cd4354a450c3e5d80959f35b8e4cf0c", 21:41:45 INFO - "slavename": "talos-linux64-ix-064", 21:41:45 INFO - "repo_path": "mozilla-central" 21:41:45 INFO - } 21:41:45 INFO - Finding installer, test and symbols from parent task. 21:41:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_fvWOcCTUCryorZcujEaA'}, attempt #1 21:41:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_fvWOcCTUCryorZcujEaA'}, attempt #1 21:41:46 INFO - Task dependencies: B-U5U7jLRKWEIoSkVqdS_A 21:41:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A'}, attempt #1 21:41:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 21:41:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/test_packages.json 21:41:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.crashreporter-symbols.zip 21:41:46 INFO - Running post-action listener: _resource_record_post_action 21:41:46 INFO - [mozharness: 2017-03-22 04:41:46.640876Z] Finished read-buildbot-config step (success) 21:41:46 INFO - [mozharness: 2017-03-22 04:41:46.641093Z] Running download-and-extract step. 21:41:46 INFO - Running pre-action listener: _resource_record_pre_action 21:41:46 INFO - Running main action method: download_and_extract 21:41:46 INFO - mkdir: /builds/slave/test/build/tests 21:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:46 INFO - trying https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.test_packages.json 21:41:46 INFO - Downloading https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:41:47 INFO - Downloaded 986 bytes. 21:41:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:41:47 INFO - Using the following test package requirements: 21:41:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:41:47 INFO - u'common': [u'target.common.tests.zip'], 21:41:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:41:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:41:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:41:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:41:47 INFO - u'mozbase': [u'target.common.tests.zip'], 21:41:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:41:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:41:47 INFO - u'web-platform': [u'target.common.tests.zip', 21:41:47 INFO - u'target.web-platform.tests.zip'], 21:41:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:41:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:41:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip 21:41:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:47 INFO - Fetch https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip into memory 21:41:48 INFO - Expected file size: 60319074 21:41:48 INFO - Obtained file size: 60319074 21:41:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:41:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip 21:41:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:58 INFO - Fetch https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.common.tests.zip into memory 21:41:59 INFO - Expected file size: 60319074 21:41:59 INFO - Obtained file size: 60319074 21:42:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.talos.tests.zip 21:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.talos.tests.zip into memory 21:42:12 INFO - Expected file size: 14404171 21:42:12 INFO - Obtained file size: 14404171 21:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:12 INFO - trying https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 21:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:42:15 INFO - Downloaded 67216881 bytes. 21:42:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 21:42:15 INFO - mkdir: /builds/slave/test/properties 21:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:42:15 INFO - Contents: 21:42:15 INFO - build_url:https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 21:42:15 INFO - Running post-action listener: _resource_record_post_action 21:42:15 INFO - Running post-action listener: set_extra_try_arguments 21:42:15 INFO - [mozharness: 2017-03-22 04:42:15.137729Z] Finished download-and-extract step (success) 21:42:15 INFO - [mozharness: 2017-03-22 04:42:15.137825Z] Running populate-webroot step. 21:42:15 INFO - Running pre-action listener: _resource_record_pre_action 21:42:15 INFO - Running main action method: populate_webroot 21:42:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:42:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:42:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:42:15 INFO - '--tppagecycles', 21:42:15 INFO - '7'], 21:42:15 INFO - 'tests': ['tsvgm']}}, 21:42:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:42:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:42:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:42:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:42:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['damp', 'tps']}, 21:42:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'tests': ['damp', 'tps']}, 21:42:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['dromaeo_dom']}, 21:42:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:42:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['basic_compositor_video']}, 21:42:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:42:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['a11yr', 21:42:15 INFO - 'ts_paint', 21:42:15 INFO - 'tpaint', 21:42:15 INFO - 'sessionrestore', 21:42:15 INFO - 'sessionrestore_no_auto_restore', 21:42:15 INFO - 'tabpaint']}, 21:42:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['tsvgx', 21:42:15 INFO - 'tsvgr_opacity', 21:42:15 INFO - 'tart', 21:42:15 INFO - 'tscrollx', 21:42:15 INFO - 'cart', 21:42:15 INFO - 'tsvg_static']}, 21:42:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:42:15 INFO - 'tsvgr_opacity', 21:42:15 INFO - 'tart', 21:42:15 INFO - 'tscrollx', 21:42:15 INFO - 'cart', 21:42:15 INFO - 'tsvg_static']}, 21:42:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'talos_options': ['--disable-e10s'], 21:42:15 INFO - 'tests': ['tp5o']}, 21:42:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:42:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'talos_options': ['--disable-e10s', 21:42:15 INFO - '--xperf_path', 21:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:15 INFO - 'tests': ['tp5n']}, 21:42:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:42:15 INFO - 'talos_options': ['--xperf_path', 21:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:15 INFO - 'tests': ['tp5n']}}, 21:42:15 INFO - 'talos.zip': {'path': '', 21:42:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:42:15 INFO - Running post-action listener: _resource_record_post_action 21:42:15 INFO - [mozharness: 2017-03-22 04:42:15.151039Z] Finished populate-webroot step (success) 21:42:15 INFO - [mozharness: 2017-03-22 04:42:15.151129Z] Running create-virtualenv step. 21:42:15 INFO - Running pre-action listener: _resource_record_pre_action 21:42:15 INFO - Running main action method: create_virtualenv 21:42:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:42:15 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 21:42:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:42:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:42:15 INFO - Using real prefix '/usr' 21:42:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:42:15 INFO - Installing distribute.............................................................................................................................................................................................done. 21:42:17 INFO - Installing pip.................done. 21:42:17 INFO - Return code: 0 21:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:42:17 INFO - Reading from file tmpfile_stdout 21:42:17 INFO - Output received: 21:42:17 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) 21:42:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:42:17 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')]} 21:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:17 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')]} 21:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:17 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:17 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 21:42:17 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 21:42:17 INFO - Using env: {'DISPLAY': ':0', 21:42:17 INFO - 'HOME': '/home/cltbld', 21:42:17 INFO - 'LANG': 'en_US.UTF-8', 21:42:17 INFO - 'LANGUAGE': 'en_US:en', 21:42:17 INFO - 'LOGNAME': 'cltbld', 21:42:17 INFO - 'MAIL': '/var/mail/cltbld', 21:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:17 INFO - 'MOZ_NO_REMOTE': '1', 21:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:17 INFO - 'NO_EM_RESTART': '1', 21:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:17 INFO - 'PWD': '/builds/slave/test', 21:42:17 INFO - 'SHELL': '/bin/bash', 21:42:17 INFO - 'SHLVL': '1', 21:42:17 INFO - 'TERM': 'linux', 21:42:17 INFO - 'TMOUT': '86400', 21:42:17 INFO - 'USER': 'cltbld', 21:42:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:17 INFO - '_': '/tools/buildbot/bin/python'} 21:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:18 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 21:42:18 INFO - Cleaning up... 21:42:18 INFO - Return code: 0 21:42:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:42:18 INFO - Using env: {'DISPLAY': ':0', 21:42:18 INFO - 'HOME': '/home/cltbld', 21:42:18 INFO - 'LANG': 'en_US.UTF-8', 21:42:18 INFO - 'LANGUAGE': 'en_US:en', 21:42:18 INFO - 'LOGNAME': 'cltbld', 21:42:18 INFO - 'MAIL': '/var/mail/cltbld', 21:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:18 INFO - 'MOZ_NO_REMOTE': '1', 21:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:18 INFO - 'NO_EM_RESTART': '1', 21:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:18 INFO - 'PWD': '/builds/slave/test', 21:42:18 INFO - 'SHELL': '/bin/bash', 21:42:18 INFO - 'SHLVL': '1', 21:42:18 INFO - 'TERM': 'linux', 21:42:18 INFO - 'TMOUT': '86400', 21:42:18 INFO - 'USER': 'cltbld', 21:42:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:18 INFO - '_': '/tools/buildbot/bin/python'} 21:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:18 INFO - Downloading/unpacking psutil>=3.1.1 21:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:20 INFO - Installing collected packages: psutil 21:42:20 INFO - Running setup.py install for psutil 21:42:20 INFO - building 'psutil._psutil_linux' extension 21:42:20 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 21:42:20 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 21:42:20 INFO - building 'psutil._psutil_posix' extension 21:42:20 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 21:42:20 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 21:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:20 INFO - Successfully installed psutil 21:42:20 INFO - Cleaning up... 21:42:21 INFO - Return code: 0 21:42:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:21 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:21 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 21:42:21 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 21:42:21 INFO - Using env: {'DISPLAY': ':0', 21:42:21 INFO - 'HOME': '/home/cltbld', 21:42:21 INFO - 'LANG': 'en_US.UTF-8', 21:42:21 INFO - 'LANGUAGE': 'en_US:en', 21:42:21 INFO - 'LOGNAME': 'cltbld', 21:42:21 INFO - 'MAIL': '/var/mail/cltbld', 21:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:21 INFO - 'MOZ_NO_REMOTE': '1', 21:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:21 INFO - 'NO_EM_RESTART': '1', 21:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:21 INFO - 'PWD': '/builds/slave/test', 21:42:21 INFO - 'SHELL': '/bin/bash', 21:42:21 INFO - 'SHLVL': '1', 21:42:21 INFO - 'TERM': 'linux', 21:42:21 INFO - 'TMOUT': '86400', 21:42:21 INFO - 'USER': 'cltbld', 21:42:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:21 INFO - '_': '/tools/buildbot/bin/python'} 21:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:42:21 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 21:42:21 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 21:42:21 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 21:42:21 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 21:42:21 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 21:42:21 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 21:42:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:42:23 INFO - Installing collected packages: mozsystemmonitor 21:42:23 INFO - Running setup.py install for mozsystemmonitor 21:42:23 INFO - Successfully installed mozsystemmonitor 21:42:23 INFO - Cleaning up... 21:42:23 INFO - Return code: 0 21:42:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:42:23 INFO - Using env: {'DISPLAY': ':0', 21:42:23 INFO - 'HOME': '/home/cltbld', 21:42:23 INFO - 'LANG': 'en_US.UTF-8', 21:42:23 INFO - 'LANGUAGE': 'en_US:en', 21:42:23 INFO - 'LOGNAME': 'cltbld', 21:42:23 INFO - 'MAIL': '/var/mail/cltbld', 21:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:23 INFO - 'MOZ_NO_REMOTE': '1', 21:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:23 INFO - 'NO_EM_RESTART': '1', 21:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:23 INFO - 'PWD': '/builds/slave/test', 21:42:23 INFO - 'SHELL': '/bin/bash', 21:42:23 INFO - 'SHLVL': '1', 21:42:23 INFO - 'TERM': 'linux', 21:42:23 INFO - 'TMOUT': '86400', 21:42:23 INFO - 'USER': 'cltbld', 21:42:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:23 INFO - '_': '/tools/buildbot/bin/python'} 21:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:23 INFO - Downloading/unpacking jsonschema==2.5.1 21:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:42:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:25 INFO - Downloading functools32-3.2.3-2.tar.gz 21:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:42:25 INFO - warning: no files found matching '*.txt' 21:42:25 INFO - no previously-included directories found matching 'build' 21:42:25 INFO - no previously-included directories found matching 'dist' 21:42:25 INFO - no previously-included directories found matching '.git*' 21:42:25 INFO - Installing collected packages: jsonschema, functools32 21:42:26 INFO - Running setup.py install for functools32 21:42:26 INFO - warning: no files found matching '*.txt' 21:42:26 INFO - no previously-included directories found matching 'build' 21:42:26 INFO - no previously-included directories found matching 'dist' 21:42:26 INFO - no previously-included directories found matching '.git*' 21:42:26 INFO - Successfully installed jsonschema functools32 21:42:26 INFO - Cleaning up... 21:42:26 INFO - Return code: 0 21:42:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:42:26 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')]} 21:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:26 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')]} 21:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:26 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:26 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 21:42:26 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 21:42:26 INFO - Using env: {'DISPLAY': ':0', 21:42:26 INFO - 'HOME': '/home/cltbld', 21:42:26 INFO - 'LANG': 'en_US.UTF-8', 21:42:26 INFO - 'LANGUAGE': 'en_US:en', 21:42:26 INFO - 'LOGNAME': 'cltbld', 21:42:26 INFO - 'MAIL': '/var/mail/cltbld', 21:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:26 INFO - 'MOZ_NO_REMOTE': '1', 21:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:26 INFO - 'NO_EM_RESTART': '1', 21:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:26 INFO - 'PWD': '/builds/slave/test', 21:42:26 INFO - 'SHELL': '/bin/bash', 21:42:26 INFO - 'SHLVL': '1', 21:42:26 INFO - 'TERM': 'linux', 21:42:26 INFO - 'TMOUT': '86400', 21:42:26 INFO - 'USER': 'cltbld', 21:42:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:26 INFO - '_': '/tools/buildbot/bin/python'} 21:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:42:26 INFO - Cleaning up... 21:42:26 INFO - Return code: 0 21:42:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:42:26 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')]} 21:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:26 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')]} 21:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:26 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:26 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 21:42:26 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 21:42:26 INFO - Using env: {'DISPLAY': ':0', 21:42:26 INFO - 'HOME': '/home/cltbld', 21:42:26 INFO - 'LANG': 'en_US.UTF-8', 21:42:26 INFO - 'LANGUAGE': 'en_US:en', 21:42:26 INFO - 'LOGNAME': 'cltbld', 21:42:26 INFO - 'MAIL': '/var/mail/cltbld', 21:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:26 INFO - 'MOZ_NO_REMOTE': '1', 21:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:26 INFO - 'NO_EM_RESTART': '1', 21:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:26 INFO - 'PWD': '/builds/slave/test', 21:42:26 INFO - 'SHELL': '/bin/bash', 21:42:26 INFO - 'SHLVL': '1', 21:42:26 INFO - 'TERM': 'linux', 21:42:26 INFO - 'TMOUT': '86400', 21:42:26 INFO - 'USER': 'cltbld', 21:42:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:26 INFO - '_': '/tools/buildbot/bin/python'} 21:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:26 INFO - Downloading/unpacking blobuploader==1.2.4 21:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:42:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:42:28 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 21:42:28 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 21:42:28 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 21:42:28 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 21:42:28 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 21:42:28 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 21:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:42:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:29 INFO - Downloading docopt-0.6.1.tar.gz 21:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:42:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:42:29 INFO - Running setup.py install for blobuploader 21:42:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:42:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:42:29 INFO - Running setup.py install for requests 21:42:29 INFO - Running setup.py install for docopt 21:42:29 INFO - Successfully installed blobuploader requests docopt 21:42:29 INFO - Cleaning up... 21:42:30 INFO - Return code: 0 21:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:30 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:30 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 21:42:30 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 21:42:30 INFO - Using env: {'DISPLAY': ':0', 21:42:30 INFO - 'HOME': '/home/cltbld', 21:42:30 INFO - 'LANG': 'en_US.UTF-8', 21:42:30 INFO - 'LANGUAGE': 'en_US:en', 21:42:30 INFO - 'LOGNAME': 'cltbld', 21:42:30 INFO - 'MAIL': '/var/mail/cltbld', 21:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:30 INFO - 'MOZ_NO_REMOTE': '1', 21:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:30 INFO - 'NO_EM_RESTART': '1', 21:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:30 INFO - 'PWD': '/builds/slave/test', 21:42:30 INFO - 'SHELL': '/bin/bash', 21:42:30 INFO - 'SHLVL': '1', 21:42:30 INFO - 'TERM': 'linux', 21:42:30 INFO - 'TMOUT': '86400', 21:42:30 INFO - 'USER': 'cltbld', 21:42:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:30 INFO - '_': '/tools/buildbot/bin/python'} 21:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:30 INFO - Running setup.py (path:/tmp/pip-1OKhFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:30 INFO - Running setup.py (path:/tmp/pip-IpTCLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:30 INFO - Running setup.py (path:/tmp/pip-84xCqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:30 INFO - Running setup.py (path:/tmp/pip-Hb5w63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:30 INFO - Running setup.py (path:/tmp/pip-qXjS5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:30 INFO - Running setup.py (path:/tmp/pip-xAFD3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:30 INFO - Running setup.py (path:/tmp/pip-GxaBJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:30 INFO - Running setup.py (path:/tmp/pip-fH96Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:30 INFO - Running setup.py (path:/tmp/pip-cLo364-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:30 INFO - Running setup.py (path:/tmp/pip-reEa_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:30 INFO - Running setup.py (path:/tmp/pip-kk1boo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:31 INFO - Running setup.py (path:/tmp/pip-GRKPdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:31 INFO - Running setup.py (path:/tmp/pip-lCI87C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:31 INFO - Running setup.py (path:/tmp/pip-sh03zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:31 INFO - Running setup.py (path:/tmp/pip-FJiXT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:31 INFO - Running setup.py (path:/tmp/pip-G50ySB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:31 INFO - Running setup.py (path:/tmp/pip-Mgn1vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:42:31 INFO - Running setup.py install for manifestparser 21:42:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:42:31 INFO - Running setup.py install for mozcrash 21:42:31 INFO - Running setup.py install for mozdebug 21:42:31 INFO - Running setup.py install for mozdevice 21:42:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:42:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:42:31 INFO - Running setup.py install for mozfile 21:42:31 INFO - Running setup.py install for mozhttpd 21:42:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozinfo 21:42:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozInstall 21:42:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozleak 21:42:32 INFO - Running setup.py install for mozlog 21:42:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for moznetwork 21:42:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozprocess 21:42:32 INFO - Running setup.py install for mozprofile 21:42:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozrunner 21:42:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:42:32 INFO - Running setup.py install for mozscreenshot 21:42:33 INFO - Running setup.py install for moztest 21:42:33 INFO - Running setup.py install for mozversion 21:42:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:42:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:42:33 INFO - Cleaning up... 21:42:33 INFO - Return code: 0 21:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:33 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:33 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 21:42:33 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 21:42:33 INFO - Using env: {'DISPLAY': ':0', 21:42:33 INFO - 'HOME': '/home/cltbld', 21:42:33 INFO - 'LANG': 'en_US.UTF-8', 21:42:33 INFO - 'LANGUAGE': 'en_US:en', 21:42:33 INFO - 'LOGNAME': 'cltbld', 21:42:33 INFO - 'MAIL': '/var/mail/cltbld', 21:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:33 INFO - 'MOZ_NO_REMOTE': '1', 21:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:33 INFO - 'NO_EM_RESTART': '1', 21:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:33 INFO - 'PWD': '/builds/slave/test', 21:42:33 INFO - 'SHELL': '/bin/bash', 21:42:33 INFO - 'SHLVL': '1', 21:42:33 INFO - 'TERM': 'linux', 21:42:33 INFO - 'TMOUT': '86400', 21:42:33 INFO - 'USER': 'cltbld', 21:42:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:33 INFO - '_': '/tools/buildbot/bin/python'} 21:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:33 INFO - Running setup.py (path:/tmp/pip-24Q5AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:33 INFO - Running setup.py (path:/tmp/pip-F9Vi8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:33 INFO - Running setup.py (path:/tmp/pip-LnwK_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:33 INFO - Running setup.py (path:/tmp/pip-ma8WP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:33 INFO - Running setup.py (path:/tmp/pip-k5naQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:33 INFO - Running setup.py (path:/tmp/pip-g2NI00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:33 INFO - Running setup.py (path:/tmp/pip-7idvxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:33 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)) 21:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:33 INFO - Running setup.py (path:/tmp/pip-I88FAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:34 INFO - Running setup.py (path:/tmp/pip-ocSuLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:34 INFO - Running setup.py (path:/tmp/pip-TSdKBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:34 INFO - Running setup.py (path:/tmp/pip-qc4wSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:34 INFO - Running setup.py (path:/tmp/pip-rDthTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:34 INFO - Running setup.py (path:/tmp/pip-ByKJ7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:34 INFO - Running setup.py (path:/tmp/pip-aNLGY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:34 INFO - Running setup.py (path:/tmp/pip-Mx7AeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:34 INFO - Running setup.py (path:/tmp/pip-z_Vi7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:34 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)) 21:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:34 INFO - Running setup.py (path:/tmp/pip-Ux4CHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:34 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)) 21:42:34 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)) 21:42:34 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)) 21:42:34 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)) 21:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:36 INFO - Downloading blessings-1.6.tar.gz 21:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:42:36 INFO - Installing collected packages: blessings 21:42:36 INFO - Running setup.py install for blessings 21:42:36 INFO - Successfully installed blessings 21:42:36 INFO - Cleaning up... 21:42:36 INFO - Return code: 0 21:42:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:37 INFO - Reading from file tmpfile_stdout 21:42:37 INFO - Current package versions: 21:42:37 INFO - argparse == 1.2.1 21:42:37 INFO - blessings == 1.6 21:42:37 INFO - blobuploader == 1.2.4 21:42:37 INFO - docopt == 0.6.1 21:42:37 INFO - functools32 == 3.2.3-2 21:42:37 INFO - jsonschema == 2.5.1 21:42:37 INFO - manifestparser == 1.1 21:42:37 INFO - mozInstall == 1.12 21:42:37 INFO - mozcrash == 1.0 21:42:37 INFO - mozdebug == 0.1 21:42:37 INFO - mozdevice == 0.49 21:42:37 INFO - mozfile == 1.2 21:42:37 INFO - mozhttpd == 0.7 21:42:37 INFO - mozinfo == 0.9 21:42:37 INFO - mozleak == 0.1 21:42:37 INFO - mozlog == 3.4 21:42:37 INFO - moznetwork == 0.27 21:42:37 INFO - mozprocess == 0.25 21:42:37 INFO - mozprofile == 0.28 21:42:37 INFO - mozrunner == 6.13 21:42:37 INFO - mozscreenshot == 0.1 21:42:37 INFO - mozsystemmonitor == 0.3 21:42:37 INFO - moztest == 0.8 21:42:37 INFO - mozversion == 1.4 21:42:37 INFO - psutil == 3.1.1 21:42:37 INFO - requests == 1.2.3 21:42:37 INFO - wsgiref == 0.1.2 21:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:37 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 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:37 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 21:42:37 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 21:42:37 INFO - Using env: {'DISPLAY': ':0', 21:42:37 INFO - 'HOME': '/home/cltbld', 21:42:37 INFO - 'LANG': 'en_US.UTF-8', 21:42:37 INFO - 'LANGUAGE': 'en_US:en', 21:42:37 INFO - 'LOGNAME': 'cltbld', 21:42:37 INFO - 'MAIL': '/var/mail/cltbld', 21:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:37 INFO - 'MOZ_NO_REMOTE': '1', 21:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:37 INFO - 'NO_EM_RESTART': '1', 21:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:37 INFO - 'PWD': '/builds/slave/test', 21:42:37 INFO - 'SHELL': '/bin/bash', 21:42:37 INFO - 'SHLVL': '1', 21:42:37 INFO - 'TERM': 'linux', 21:42:37 INFO - 'TMOUT': '86400', 21:42:37 INFO - 'USER': 'cltbld', 21:42:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:37 INFO - '_': '/tools/buildbot/bin/python'} 21:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 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)) 21:42:37 INFO - Cleaning up... 21:42:37 INFO - Return code: 0 21:42:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', '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 21:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:42:37 INFO - Using env: {'DISPLAY': ':0', 21:42:37 INFO - 'HOME': '/home/cltbld', 21:42:37 INFO - 'LANG': 'en_US.UTF-8', 21:42:37 INFO - 'LANGUAGE': 'en_US:en', 21:42:37 INFO - 'LOGNAME': 'cltbld', 21:42:37 INFO - 'MAIL': '/var/mail/cltbld', 21:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:37 INFO - 'MOZ_NO_REMOTE': '1', 21:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:37 INFO - 'NO_EM_RESTART': '1', 21:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:37 INFO - 'PWD': '/builds/slave/test', 21:42:37 INFO - 'SHELL': '/bin/bash', 21:42:37 INFO - 'SHLVL': '1', 21:42:37 INFO - 'TERM': 'linux', 21:42:37 INFO - 'TMOUT': '86400', 21:42:37 INFO - 'USER': 'cltbld', 21:42:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:37 INFO - '_': '/tools/buildbot/bin/python'} 21:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:42:37 INFO - Cleaning up... 21:42:37 INFO - Return code: 0 21:42:37 INFO - Running post-action listener: _resource_record_post_action 21:42:37 INFO - Running post-action listener: _start_resource_monitoring 21:42:37 INFO - Starting resource monitoring. 21:42:37 INFO - [mozharness: 2017-03-22 04:42:37.681706Z] Finished create-virtualenv step (success) 21:42:37 INFO - [mozharness: 2017-03-22 04:42:37.682295Z] Running install step. 21:42:37 INFO - Running pre-action listener: _resource_record_pre_action 21:42:37 INFO - Running main action method: install 21:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:37 INFO - Reading from file tmpfile_stdout 21:42:37 INFO - Detecting whether we're running mozinstall >=1.0... 21:42:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:42:37 INFO - Reading from file tmpfile_stdout 21:42:37 INFO - Output received: 21:42:37 INFO - Usage: mozinstall [options] installer 21:42:37 INFO - Options: 21:42:37 INFO - -h, --help show this help message and exit 21:42:37 INFO - -d DEST, --destination=DEST 21:42:37 INFO - Directory to install application into. [default: 21:42:37 INFO - "/builds/slave/test"] 21:42:37 INFO - --app=APP Application being installed. [default: firefox] 21:42:37 INFO - mkdir: /builds/slave/test/build/application 21:42:37 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'] 21:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:42:54 INFO - Reading from file tmpfile_stdout 21:42:54 INFO - Output received: 21:42:54 INFO - /builds/slave/test/build/application/firefox/firefox 21:42:54 INFO - Running post-action listener: _resource_record_post_action 21:42:54 INFO - [mozharness: 2017-03-22 04:42:54.732649Z] Finished install step (success) 21:42:54 INFO - [mozharness: 2017-03-22 04:42:54.732923Z] Running run-tests step. 21:42:54 INFO - Running pre-action listener: _resource_record_pre_action 21:42:54 INFO - Running main action method: run_tests 21:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:54 INFO - Python 2.7.3 21:42:54 INFO - Return code: 0 21:42:54 INFO - grabbing minidump binary from tooltool 21:42: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')]} 21:42:54 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 0x10ec400>, '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 0x10ed3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42:54 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 21:42:54 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 21:42:54 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 21:42:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:54 INFO - Return code: 0 21:42:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:42:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:54 INFO - ENV: RUST_BACKTRACE is now 1 21:42:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:42:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 21:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 21:42:54 INFO - Using env: {'DISPLAY': ':0', 21:42:54 INFO - 'HOME': '/home/cltbld', 21:42:54 INFO - 'LANG': 'en_US.UTF-8', 21:42:54 INFO - 'LANGUAGE': 'en_US:en', 21:42:54 INFO - 'LOGNAME': 'cltbld', 21:42:54 INFO - 'MAIL': '/var/mail/cltbld', 21:42:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:54 INFO - 'MOZ_NO_REMOTE': '1', 21:42:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:54 INFO - 'NO_EM_RESTART': '1', 21:42:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:54 INFO - 'PWD': '/builds/slave/test', 21:42:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:54 INFO - 'RUST_BACKTRACE': '1', 21:42:54 INFO - 'SHELL': '/bin/bash', 21:42:54 INFO - 'SHLVL': '1', 21:42:54 INFO - 'TERM': 'linux', 21:42:54 INFO - 'TMOUT': '86400', 21:42:54 INFO - 'USER': 'cltbld', 21:42:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205', 21:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:54 INFO - '_': '/tools/buildbot/bin/python'} 21:42:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 21:42:55 INFO - mozversion application_buildid: 20170322034826 21:42:55 INFO - mozversion application_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 21:42:55 INFO - mozversion application_display_name: Nightly 21:42:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:55 INFO - mozversion application_name: Firefox 21:42:55 INFO - mozversion application_remotingname: firefox 21:42:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:42:55 INFO - mozversion application_vendor: Mozilla 21:42:55 INFO - mozversion application_version: 55.0a1 21:42:55 INFO - mozversion platform_buildid: 20170322034826 21:42:55 INFO - mozversion platform_changeset: 201231223cd4354a450c3e5d80959f35b8e4cf0c 21:42:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:42:55 INFO - mozversion platform_version: 55.0a1 21:42:55 INFO - using testdate: 1490157775 21:42:55 INFO - actual date: 1490157775 21:42:55 INFO - starting webserver on 'localhost:49339' 21:42:55 INFO - SUITE-START | Running 2 tests 21:42:55 INFO - TEST-START | dromaeo_css 21:42:55 INFO - operating with platform_type : linux_ 21:42:55 INFO - Initialising browser for dromaeo_css test... 21:42:55 INFO - TEST-INFO | started process 1001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgK21N/profile http://localhost:49339/getInfo.html) 21:42:59 INFO - PID 1001 | __metrics Screen width/height:1600/1200 21:42:59 INFO - PID 1001 | colorDepth:24 21:42:59 INFO - PID 1001 | Browser inner width/height: 1024/697 21:42:59 INFO - PID 1001 | __metrics 21:43:00 INFO - PID 1001 | 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" 21:43:00 INFO - PID 1001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:43:01 INFO - TEST-INFO | 1001: exit 0 21:43:01 INFO - Browser initialized. 21:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:43:01 INFO - TEST-INFO | started process 1106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgK21N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:43:13 INFO - PID 1106 | RSS: Main: 144793600 21:43:13 INFO - PID 1106 | 21:46:15 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49339/tests/dromaeo/cssquery-ext.html) 21:46:17 INFO - PID 1106 | RSS: Main: 328851456 21:46:17 INFO - PID 1106 | 21:48:03 INFO - PID 1106 | ************************* 21:48:03 INFO - PID 1106 | A coding exception was thrown and uncaught in a Task. 21:48:03 INFO - PID 1106 | 21:48:03 ERROR - PID 1106 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:48:03 INFO - PID 1106 | Full stack: 21:48:03 INFO - PID 1106 | ************************* 21:49:20 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-ext.html (next: http://localhost:49339/tests/dromaeo/cssquery-jquery.html) 21:49:20 INFO - PID 1106 | RSS: Main: 227229696 21:49:20 INFO - PID 1106 | 21:52:22 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49339/tests/dromaeo/cssquery-mootools.html) 21:52:23 INFO - PID 1106 | RSS: Main: 212926464 21:52:23 INFO - PID 1106 | 21:55:25 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49339/tests/dromaeo/cssquery-prototype.html) 21:55:25 INFO - PID 1106 | RSS: Main: 201949184 21:55:25 INFO - PID 1106 | 21:58:28 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49339/tests/dromaeo/cssquery-yui.html) 21:58:29 INFO - PID 1106 | RSS: Main: 183934976 21:58:29 INFO - PID 1106 | 22:01:31 INFO - PID 1106 | Cycle 1(1): loaded http://localhost:49339/tests/dromaeo/cssquery-yui.html (next: http://localhost:49339/tests/dromaeo/cssquery-dojo.html) 22:01:32 INFO - PID 1106 | RSS: Main: 269533184 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | __start_tp_report 22:01:32 INFO - PID 1106 | _x_x_mozilla_page_load 22:01:32 INFO - PID 1106 | _x_x_mozilla_page_load_details 22:01:32 INFO - PID 1106 | |i|pagename|runs| 22:01:32 INFO - PID 1106 | |0;dojo.html;3265.4448743713565;3287.5233091201776;3308.3714094322063;3318.4192766265896;3342.348242092791;5691.4024027477035;5709.200711900332;5738.713064346782;5764.711764411783;5795.594308398403;5817.505512031483;5824.941750582493;5837.270341207349;5870.735816888239;5874.001419758641;5105.132127538309;5170.663906846053;5178.559822415081;5269.077911365515;5352.437994010631;5246.685198888079;5256.684598924076;5318.202269659543;5324.494173053554;5335.7332133393365;5085.923711144317;5137.3064636274;5150.150225212854;5207.739613019334;5228.4510126436935;5226.660267082628;5244.318238628954;5259.8422047338645;5294.205869119624;5328.573714102862;5197.870053248661;5247.291615631879;5276.261323414725;5278.551323137538;5279.577633789288;5627.380988091307;5736.139579063132;5753.539716822645;5818.738156782955;5856.882862342729;6098.644029113934;6194.938050619481;6261.279952805395;6264.966280563747;6270.749170033193;6201.751929922798;6228.190335256433;6229.595076320024;6230.252369715663;6236.844078898019;5711.971440142773;5756.107803290497;5765.308163020422;5775.971120144414;5811;6213.844653883689;6296.716647750863;6301.117843501914;6340.841478963062;6352.523560732963;5883.588148829626;5937.168796368512;5941.168236446901;5950.256217972754;6176.6911654418;6067;6101.435748753901;6103.337669688843;6111.257501106225;6114.388610881752;6122.86583998841;6123.414962257987;6129.09499847894;6131.296552205817;6136.182108626252;6123.28262147438;6123.608950580373;6127.903150210862;6140.854922927007;6148.231471066117;4642.605378542794;4690.9765451172525;4736.763161841963;4751.3348131261655;4762.476127625959;4198;4215.978920105441;4231.640310573635;4243.42713733642;4253.680973926967;5817.912731309034;5834.299884013861;5835.503982161479;5859.941400586024;5887.5289976802605;6019.277686677539;6110.419510146529;6263.937360626426;6269.216347956505;6339.556231063873;5870.3249126350165;5904.7342869570975;5930.733117009659;5951.166836642873;5964.671943043088;5325.813596524103;5350.8662283442445;5352.5450336721815;5357.7589008494715;5358.276632654542;6282.685865706788;6544.3782840630065;6562.704678289393;6563.310852360433;6575.901361479581;6123.050927106306;6239.625622462667;6248.0940263660605;6258.749650013949;6304.936950630435;6487.3836985486305;6553.311902250195;6557.049227862029;6563.343665633399;6563.540552161494;6199.56603037783;6207.068939659087;6208.534359923115;6222.751089956351;6233.252009758858;6003.90994135097;6097.524678803442;6230.626162430088;6286.402791734778;6292.370762923671;6061.575689701678;6063.8180854572665;6066.787662431793;6067.635941843327;6112.602680825732;5936.198613187337;6001.399860013964;6039.335673076046;6042.788502402394;6055.636661800306;5878.088896221093;5919.467247947706;5924.6149000314845;5932.555058370725;5947.405259474191;5955.880882382415;5982.282126144716;5982.790602329072;5988.6107403020405;5996.610220335839;5816.331121921034;5841.386654401226;5843.912341314799;5844.707764611838;5846.970765146147 22:01:32 INFO - PID 1106 | |1;ext.html;645.3320812958589;711.2425267090548;730.3864753606971;1082.4209048159237;1107.186218129674;28586.428271434557;35482.822585887065;36179.63820361796;36228;36253.81873090631;39311;39831.62273093132;39851.20297594046;39853;39892.80053599728;5957.9404205958035;6100.176476175704;7877.960610196956;8063.758087257392;8074.838503229932;7623.466357354987;7768.300852923236;7770.456068075208;7772.727954521592;7780.260875216845;7756.457048006641;7833.804154896116;7836;7839.843203135933;7843.372530197599;7697.3457256133015;7794.961025194894;7805.024371953506;7808.570528620923;7851.842963140763;7916.247956444128;8187.918120818775;8188.590570471452;8191.0580283267;8197;40423.59576404228;40799.7960010201;40844.18311633751;40903.38644920329;40916.79541602303;3016.7737419693613;3036.6052413186144;3047.131567503251;3073.585066016104;3107.704768047032;28313.57529637057;28322.02618725025;28459.57310640342;28785.136445906657;29739.553906691417;3471.3925063114107;3535.8762443314617;3546.148924258185;3568.2863427314383;3606.6393360663724;202060;203343;203514;204495;204681.97659011759;49235;49521.50478495169;49606.751966239935;49621.25568116481;49637.25544116841;51432.22851657228;51558.48441515537;51600.741996290526;51651.483485165416;51698.48301516937;14697.338619762137;14983.250837458301;14991.175485348193;14996.625084372978;14998.400063997318;9511.57197926095;9664.806703865883;10891;11992.400379980965;12026.873013016504;13387.464501419834;13414.798778018338;13450.461981520826;13456.259905705085;13518.729625407437;5422.457754224546;5453.863653408696;5481.150421684645;5487.451254874481;5661.886762264731;1017.2421545948316;1017.9083882450467;1036.3212096076932;1038.9584416623402;1039.293280569205;24309;24410.145644902343;24511.509769804503;24518.264452066465;24559;1106.4910141334915;1111.2054880760295;1144.2333636463588;1148.7817314710346;1156.7108222944264;12148.271103733805;12808.743825123445;12891.548795792101;12944.482220711066;12960.935195324151;303518;304046;304297;304435;304612;53585.46414535805;53883.461165387846;53948.73025634847;54069.45930540723;54147.18779218315;1450.8839292856546;1474.0639693794517;1496.453794365049;1501.909885406879;1511.5389806109242;23182;23926.12886453567;23967.880160599085;24123.75876241215;24219.152329669083;39493.40759888547;43155.568444316414;43810.342844856714;43920.78039609781;44085;199365;199870;200117;200518;200617;26634.334141646614;26696.733032669425;27139.185824425298;28573.285602863896;29539;39658;39810.40284395794;39953.40069899012;40049.59950400459;40148.19703605853;33494.330113398086;33874.49188262227;34214;34349.14127146841;34418.31163376669;33140.17149571184;33248;33298;33981.49027764536;34404;34487.4826877602;35019.47470787991;35897.820510897276;35947.46078808768;35951.820240898625;25647.87176064108;28495.43009139764;28550.143495695163;28597.85701071481;28963.131106066852;23681.17115900935;24179.578863726238;24328.1485148019;24570.87714561416;24876.50246995086 22:01:32 INFO - PID 1106 | |2;jquery.html;434.4482507215834;442.32103720788575;444.5909763018023;462.29500012480986;462.7269910752655;18545.258189672415;19832;20236.797632023674;20424.795752042475;21868;21574.676379854314;21941.451463713416;22445.653260804324;22655.20706775263;22706.659400109012;5773.653580785166;5885.146653735206;5936.762529498815;5936.792212272571;5940.465358117768;5542.806001789938;5907.704614769265;5946.583739138262;5950.672713000783;5954.642721436728;5808.941910580882;5915.112733090028;5916.615419997708;5917.792877249297;5920.082387229986;5778.913316300259;5805.7387417566315;5826.242588463515;5843.328017278025;5844.853878653025;5245.632805703603;5262.8684282892855;5302.443243459458;5305.4164041955355;5310.787568497255;25942.870285648452;25949.351266218306;26210.737892621022;26218;26231.73768262312;2001.8898960557165;2006.1273346094495;2008.8794672319561;2024.5950809837943;2033.1359172351692;15465.989421375261;15725;15837.287322070535;15936.442224522087;16655.083970381624;1894.4884881082169;1904;1912.837408820252;1920.5294702797903;1926.7398901148306;98267.50866245695;98559;99530;100002.49998750033;101988.49005754924;12239;12271.69320766988;12323.815142772866;12389.132760706663;12674.514508510234;17644.382446614305;17667;17672;17674.116294185496;17681.823181768017;8793.912060879436;9065.274778017743;9097.636094556276;9131.406458580172;9218.216451601555;8290.544020078833;8340.165983401612;8377.287930525852;8595.699150529827;8601.440906341068;7531.698732050657;7574.166841647414;7738.845223095506;7768.961155194301;7846.215378462108;2221.622324204889;2226.2208227120377;2264.4904896398507;2289.2674344209695;2295.3114065780533;1000.6347683095618;1006.5872992073215;1026.9691909242736;1029.763154474475;1036.5744158668601;19656.410307690792;20188.293409730588;20262.493437664176;20414.89792551028;20436.28473003438;1069.550788668761;1069.5775168808277;1080.7190130565953;1088.9074428673493;1089.7221208591916;10861.07680847121;12176;13119.803202951773;13329.66675833112;13420.865791342158;308199;499257;661371;689766;699913;113556;113955;115318;118622.76526816837;119069;1250.6185613388004;1285.4665313894816;1291.109134697056;1299.5971248912867;1302.8892544133664;20049.59900802005;20307.492312692302;20863;20958.685619715412;21104.15583376709;48046.5195348056;49050.26424603562;50212.49787502078;50255.06515007217;50755.492445076554;65957.67021165055;66624.6668766653;67022.3297767016;67478.66260668666;67720;8767.473951562926;9018.278537716837;9130.726078217664;9218.170364667212;9324.580393882155;13439.932800335935;13581.45674173022;13651.180929144282;13751.587452376445;13851.238181900093;10834.837477438003;11456.82814757796;11586.71033224176;12069.57756478519;12290.569830055905;11701;11741.354225517678;11754.412279386168;12166.330851803235;12345.321007344683;11740;11916.16586838913;12107.33409662477;12845.42195601219;13026.28355440422;12268.386580670753;13056.543020994219;13572.79640805369;13781.655458613615;14133.15201087938;12752.936235318764;12780.488780448677;12817.23096614206;12973.805392918925;13149.079564430398 22:01:32 INFO - PID 1106 | |3;mootools.html;1182.4797089280721;1322.4313545175573;1346.521984695433;1382.4884792626724;1396.6717821311993;9144;10474;10854.294470859388;10903;10910.018098371145;10603;10628.468576571178;10654.680359589205;10664.30682005671;10681.465926703653;1860.5906700525863;1922.2695375757194;2326.7091613548264;2369.6327069304284;2374.620060790274;2348.8708121053337;2387.77316154965;2392.497575509145;2396.125414223813;2415.6014257647466;2350.5416443793383;2363.8581685098948;2367.822413318999;2369.917052903149;2370.5495955768433;2373.976260237401;2376.3346263046374;2376.3940195250275;2379.928602141921;2389.3190440724484;2125.543008253233;2136.198925402974;2161.6325224711836;2161.8054375106317;2164.794344537282;10780.622678206226;10884.564617415293;10891.564337426493;10897.455127243606;10912.345259284468;6093.542984276197;6268.592541484834;6283.654399008053;6302.621842689453;6308.653024083674;3815.3895376739865;3939.9962048198627;4059.2490389278078;4102.220578090153;4122.835086596532;1263.456713613146;1283.2364742977913;1293.1012946002531;1320.610419926124;1421.6588018875498;16650;16793.748093778602;16818.243179056848;16837.410690625893;16846.747298790404;5216.817411390583;5551.361593416728;5570.470805273492;5580.190872323572;5607.495325420732;13312.933435332956;13338.533151339656;13371.06402551812;13373.732525349438;13374.866251337362;6335.36646335372;6372.7132279047555;6374.203224596926;6378.936210637834;6379.904301435482;4870.756462176948;5007.624428167829;5644.887102258014;5677.574181936288;5790.449907258803;4100;4117.982684626989;4229.175310814362;4237.978810105929;4243.957560424418;1271.167385362589;1272.961811145667;1275.5981865712272;1276.113101394522;1293.9741205175844;834.0950069175013;837.2799392522426;844.5481667307961;865.8051938313829;871.3987348729356;6247.875042499125;6258.561900667;6364.681765911686;6625.4037136657935;7048.436125109979;892.4868200784575;896.7221709064687;902.7427183252742;904.9095090490898;907.4056492997097;3442.759006869495;3481.9129521762156;3484.1115515543374;3535.524456034865;3596.928061438809;14234.359453824603;14787.408503659948;14814.259287035606;14815.555533334018;14882.925585372004;14536.491222807152;14595.85404145945;14633.780493292608;14640.341184646717;14653.853461465462;10127;10173.593056277667;10251.436171010666;10441.791164176673;10444.582216711398;6496.642684652389;6578.375054370019;6603.702833372606;6626.072349870926;6662.433693136138;12768.170068945488;13071.085024048225;13143.474261029452;13156.671083222996;13158.60524184276;13205.735885282433;13222.537211197561;13248.867511324763;13527.72944541084;13797.172169669851;7478.813029674302;7702.499337543042;8243.711470098759;8446.197611226924;8454.83090338202;9175.128362805523;9504;9506.239500839778;9508.381955172892;9510.334276600572;8349.666013359398;8514.872276915976;8540.487570745776;8599.52702601363;8633.95683021581;8141.22658347456;8142.3486121111355;8166.754997350089;8181.304589109992;8216.589170541569;7338.926610734038;7461.104667439942;7537.698492060256;7568.772936811904;7576.393888489018;5806.65160090396;5872.559558033079;5948.643081415129;5961.672108034099;6276.905846412216;5890.558208134321;5914.911276330945;5933.910991335047;5981.760729570942;6187.876242475035 22:01:32 INFO - PID 1106 | |4;prototype.html;404.7834408591404;412.1591952417069;415.13444468283626;426.4307149954809;436.25836078666254;5417;5586.581006424514;5629.746661400237;5729.312482502106;5751.626144300618;5443.782248710057;5605.159226116085;5610.13042978338;5630;5643.294588176478;4522.977385113069;4535.682502224846;4542.750148741818;4551.180787458256;4579.725216487005;4403.273459879116;4521.819127234907;4538.795754191053;4544.500104988449;4592.839250626229;4532.3654688343495;4534.229181039232;4536.591706746392;4554.157480866051;4557.313793896246;4511.338310396849;4511.436070491189;4528.479224889131;4531.934995276108;4542.88699268678;4058.715889887709;4117.505899292074;4122.9381559276635;4141.6065473780245;4155.771432571208;5513.173024046385;5518.779248830042;5521.2270282160525;5551.945780061363;5577.637453565546;5246.554042906358;5262.8684282892855;5270.499302566289;5276;5298.536180675966;5761.366249712528;5929.169916211734;5953.2856057272975;5984.8503787405225;5996.370381109964;4534.6372290216705;4540.909181816378;4557.453105627313;4558.407407037064;4569.634429245685;6118.632882027093;6211.9999999999545;6218.440340369343;6235.688215589203;6239.188905442264;4643.094596553639;4658.114958157939;4662.790174442158;4668.159731248408;4699.295105734167;4772.188727916263;4777.355057067251;4781.808727650925;4790.305405716152;4804;5231.581473482112;5243.842684719464;5261.210818377274;5280.20796880471;5285.432333175091;5690;5920.230370051866;5970.432808883149;5981.491573216325;5993.670348130895;1431.591996281055;1460.1458146984132;1489.3446883371282;1536.8155821301516;1540.5686407805833;1025.477006726575;1050.5850189175233;1064.6912395405245;1068.871735391758;1079.5034284229184;5689.573282003867;5693.345265294462;5708.600397972185;5723.341815691166;5735.139729040678;6013.6692481913915;6041.214642096499;6062.666553339609;6085.36103709113;6091.751191005833;5513.5037846594;5660.235868157828;5672.744726487318;5675.914861277084;5724.484796368347;3208.598925134358;3219.9535151075993;3220.146661134801;3224.7903886247786;3232.725218356466;6045.304789949124;6241.500679945593;6247.531435142382;6251.437370636573;6284.465820405317;6130.448259656652;6164.4143806338325;6186.783462578788;6194.163787888668;6196.845078872974;6256.436920677161;6261.655608941552;6274.486287678915;6278.717457714505;6282.748690052438;5862;5986.610870293417;6040.516758659384;6049.122877182695;6055.5458340623745;5965.940340596539;5986.281646202484;5987.251593550806;5987.730552125077;6009.36901625323;6055.424734650202;6204.3795620437595;6251.218207897442;6267.46726528232;6275.6862156892885;4356.390105385185;4361.323994780814;4365.192439398721;4371.584699453547;4375.934360984652;5846.035404158266;6023.427774361428;6056.942453051751;6110.938890611037;6113;5830.62100963436;5915.615484993462;5952.375000624872;5967.254093238345;5983.311919129356;5945.672987985529;5954.702264886825;5957.225560677258;5969.910451343147;5971.552133589911;5753.1370294456165;5897.823065308047;5945.91081133792;5952.553558483044;5966.552508561788;5966.731497082555;5984.730687119003;5993.101034844808;5998.70006499682;6010.549208809444;5714.9142762857755;5786.652800831964;5836.978528757366;5852.297724273115;5852.600433822113 22:01:32 INFO - PID 1106 | |5;yui.html;626.6897885546649;655.5902560899438;656.781670002146;661.4212564006493;682.3517658224687;15073.397064117422;15663.765043524329;15700.214989250535;15898.602534936632;16359.83640163598;14843.92578037111;15035.849641503582;15121.470748523803;15192;15711.685766284667;797.5214871077351;816.163432481708;820.7906983719143;820.7989042684551;821.8191997760483;794.0947320055113;820.1675299570941;824.3899514359391;827.4125370986607;828.5194587139445;867.0982178534317;873.5457562067721;873.5763154869883;873.829603227371;874.152072489684;862.258457726358;863.3826813828143;865.3466632692308;866.2117473099512;866.5407334112899;637.3021541412146;637.6939069246741;637.7959053103009;638.594492497263;639.4788247578209;16706;17096;17154.99787537176;17156.227969741267;17292.22185001678;15395.461158859498;15489;15725.191602965691;15936;16151.434699785452;12035.57875474363;12497.18768280059;12597.433115509824;12880.742385152245;12913.418896149697;3158.178873492908;3168.17627416871;3200.519922011694;3240.5301231321564;3273.018094571619;83060;83060.58469707673;83406;84949.57525212334;85744.57127714384;11052.944735276273;11213.71965700864;11216.327020378803;11226.438678066064;11364.48859801311;21260.25589104374;21662.566748665253;21668.24161154352;21729.45676358072;21867.781322186893;8119.228673276029;8157.184281571914;8182.345412366996;8271.627776750061;8414.621342039623;4247.893802654959;4355.673324500675;4363.716358436755;4375.890602734893;4405.273129933525;4254.446921900195;4348.043430445297;4350.760708161019;4361.1495758327455;4362.280223763107;772.3743767548303;783.475071701961;787.5550314072531;796.0248695348267;816.5631387207816;556.9610127291131;564.4186487917369;566.6854895533019;572.0503963420701;584.5878655547829;9858.276672270486;9991.755153029357;10482;10576.788464230825;10577.788444231071;568.2357229526281;568.3208565763872;570.5549671256426;571.3914680864866;577.982660520185;4403.207422663952;5035.219540971156;5253.133233016586;5301.310829592206;5316.362036555638;77165;77172.22827771763;79211;79583.60208198921;81077;55651;58008.709956449944;69535;70150;70368;49789.751051244515;50639.49360506421;50847.491525084275;56810.14784778232;59032.40967590441;9558;9961.850572241277;10035.09684128432;10115.494225288854;10232.386056836614;28547.42905141927;28855.5671664921;28952.420951581273;29760.40479190361;30572.388552229277;30071.09786706402;30799.846000769852;35376.646233537336;35419.29161416706;36080.45879311865;12824.29466379358;12874.67813304675;13015.219086854819;13186.736265274832;13229.206247625174;13280.867191327963;13293.66765830862;13536.458541658223;13561.457541698615;14085.295735212994;12581;12586.685332866386;12972.935135324264;13058.477660893837;13628.182309061489;13240.602781916557;13799.448022079005;13903;14211.64470888236;14399.496017639332;13188.406521706738;13950;13971.650708732363;14224.715505690036;14389.064710793766;10217.897821021694;10581.735456613646;10658.946705266424;10798.35390946502;11119.277246979244;10807;10830.296030757976;11402.885971140515;11898.643040708792;11911.940440297743 22:01:32 INFO - PID 1106 | __end_tp_report 22:01:32 INFO - PID 1106 | __start_cc_report 22:01:32 INFO - PID 1106 | _x_x_mozilla_cycle_collect,1893 22:01:32 INFO - PID 1106 | __end_cc_report 22:01:32 INFO - PID 1106 | __startTimestamp1490158892201__endTimestamp 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | ------- Summary: start ------- 22:01:32 INFO - PID 1106 | Number of tests: 6 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#0] dojo.html Cycles:165 Average:5741.61 Median:5932.56 stddev:664.81 (11.2%) stddev-sans-first:637.84 22:01:32 INFO - PID 1106 | Values: 3265.4 3287.5 3308.4 3318.4 3342.3 5691.4 5709.2 5738.7 5764.7 5795.6 5817.5 5824.9 5837.3 5870.7 5874.0 5105.1 5170.7 5178.6 5269.1 5352.4 5246.7 5256.7 5318.2 5324.5 5335.7 5085.9 5137.3 5150.2 5207.7 5228.5 5226.7 5244.3 5259.8 5294.2 5328.6 5197.9 5247.3 5276.3 5278.6 5279.6 5627.4 5736.1 5753.5 5818.7 5856.9 6098.6 6194.9 6261.3 6265.0 6270.7 6201.8 6228.2 6229.6 6230.3 6236.8 5712.0 5756.1 5765.3 5776.0 5811.0 6213.8 6296.7 6301.1 6340.8 6352.5 5883.6 5937.2 5941.2 5950.3 6176.7 6067.0 6101.4 6103.3 6111.3 6114.4 6122.9 6123.4 6129.1 6131.3 6136.2 6123.3 6123.6 6127.9 6140.9 6148.2 4642.6 4691.0 4736.8 4751.3 4762.5 4198.0 4216.0 4231.6 4243.4 4253.7 5817.9 5834.3 5835.5 5859.9 5887.5 6019.3 6110.4 6263.9 6269.2 6339.6 5870.3 5904.7 5930.7 5951.2 5964.7 5325.8 5350.9 5352.5 5357.8 5358.3 6282.7 6544.4 6562.7 6563.3 6575.9 6123.1 6239.6 6248.1 6258.7 6304.9 6487.4 6553.3 6557.0 6563.3 6563.5 6199.6 6207.1 6208.5 6222.8 6233.3 6003.9 6097.5 6230.6 6286.4 6292.4 6061.6 6063.8 6066.8 6067.6 6112.6 5936.2 6001.4 6039.3 6042.8 6055.6 5878.1 5919.5 5924.6 5932.6 5947.4 5955.9 5982.3 5982.8 5988.6 5996.6 5816.3 5841.4 5843.9 5844.7 5847.0 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#1] ext.html Cycles:180 Average:39677.74 Median:33927.99 stddev:62978.23 (185.6%) stddev-sans-first:63086.71 22:01:32 INFO - PID 1106 | Values: 645.3 711.2 730.4 1082.4 1107.2 28586.4 35482.8 36179.6 36228.0 36253.8 39311.0 39831.6 39851.2 39853.0 39892.8 5957.9 6100.2 7878.0 8063.8 8074.8 7623.5 7768.3 7770.5 7772.7 7780.3 7756.5 7833.8 7836.0 7839.8 7843.4 7697.3 7795.0 7805.0 7808.6 7851.8 7916.2 8187.9 8188.6 8191.1 8197.0 40423.6 40799.8 40844.2 40903.4 40916.8 3016.8 3036.6 3047.1 3073.6 3107.7 28313.6 28322.0 28459.6 28785.1 29739.6 3471.4 3535.9 3546.1 3568.3 3606.6 202060.0 203343.0 203514.0 204495.0 204682.0 49235.0 49521.5 49606.8 49621.3 49637.3 51432.2 51558.5 51600.7 51651.5 51698.5 14697.3 14983.3 14991.2 14996.6 14998.4 9511.6 9664.8 10891.0 11992.4 12026.9 13387.5 13414.8 13450.5 13456.3 13518.7 5422.5 5453.9 5481.2 5487.5 5661.9 1017.2 1017.9 1036.3 1039.0 1039.3 24309.0 24410.1 24511.5 24518.3 24559.0 1106.5 1111.2 1144.2 1148.8 1156.7 12148.3 12808.7 12891.5 12944.5 12960.9 303518.0 304046.0 304297.0 304435.0 304612.0 53585.5 53883.5 53948.7 54069.5 54147.2 1450.9 1474.1 1496.5 1501.9 1511.5 23182.0 23926.1 23967.9 24123.8 24219.2 39493.4 43155.6 43810.3 43920.8 44085.0 199365.0 199870.0 200117.0 200518.0 200617.0 26634.3 26696.7 27139.2 28573.3 29539.0 39658.0 39810.4 39953.4 40049.6 40148.2 33494.3 33874.5 34214.0 34349.1 34418.3 33140.2 33248.0 33298.0 33981.5 34404.0 34487.5 35019.5 35897.8 35947.5 35951.8 25647.9 28495.4 28550.1 28597.9 28963.1 23681.2 24179.6 24328.1 24570.9 24876.5 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#2] jquery.html Cycles:180 Average:33915.26 Median:20419.85 stddev:97906.28 (479.5%) stddev-sans-first:98148.66 22:01:32 INFO - PID 1106 | Values: 434.4 442.3 444.6 462.3 462.7 18545.3 19832.0 20236.8 20424.8 21868.0 21574.7 21941.5 22445.7 22655.2 22706.7 5773.7 5885.1 5936.8 5936.8 5940.5 5542.8 5907.7 5946.6 5950.7 5954.6 5808.9 5915.1 5916.6 5917.8 5920.1 5778.9 5805.7 5826.2 5843.3 5844.9 5245.6 5262.9 5302.4 5305.4 5310.8 25942.9 25949.4 26210.7 26218.0 26231.7 2001.9 2006.1 2008.9 2024.6 2033.1 15466.0 15725.0 15837.3 15936.4 16655.1 1894.5 1904.0 1912.8 1920.5 1926.7 98267.5 98559.0 99530.0 100002.5 101988.5 12239.0 12271.7 12323.8 12389.1 12674.5 17644.4 17667.0 17672.0 17674.1 17681.8 8793.9 9065.3 9097.6 9131.4 9218.2 8290.5 8340.2 8377.3 8595.7 8601.4 7531.7 7574.2 7738.8 7769.0 7846.2 2221.6 2226.2 2264.5 2289.3 2295.3 1000.6 1006.6 1027.0 1029.8 1036.6 19656.4 20188.3 20262.5 20414.9 20436.3 1069.6 1069.6 1080.7 1088.9 1089.7 10861.1 12176.0 13119.8 13329.7 13420.9 308199.0 499257.0 661371.0 689766.0 699913.0 113556.0 113955.0 115318.0 118622.8 119069.0 1250.6 1285.5 1291.1 1299.6 1302.9 20049.6 20307.5 20863.0 20958.7 21104.2 48046.5 49050.3 50212.5 50255.1 50755.5 65957.7 66624.7 67022.3 67478.7 67720.0 8767.5 9018.3 9130.7 9218.2 9324.6 13439.9 13581.5 13651.2 13751.6 13851.2 10834.8 11456.8 11586.7 12069.6 12290.6 11701.0 11741.4 11754.4 12166.3 12345.3 11740.0 11916.2 12107.3 12845.4 13026.3 12268.4 13056.5 13572.8 13781.7 14133.2 12752.9 12780.5 12817.2 12973.8 13149.1 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#3] mootools.html Cycles:180 Average:6869.28 Median:3483.01 stddev:4467.27 (128.3%) stddev-sans-first:4459.36 22:01:32 INFO - PID 1106 | Values: 1182.5 1322.4 1346.5 1382.5 1396.7 9144.0 10474.0 10854.3 10903.0 10910.0 10603.0 10628.5 10654.7 10664.3 10681.5 1860.6 1922.3 2326.7 2369.6 2374.6 2348.9 2387.8 2392.5 2396.1 2415.6 2350.5 2363.9 2367.8 2369.9 2370.5 2374.0 2376.3 2376.4 2379.9 2389.3 2125.5 2136.2 2161.6 2161.8 2164.8 10780.6 10884.6 10891.6 10897.5 10912.3 6093.5 6268.6 6283.7 6302.6 6308.7 3815.4 3940.0 4059.2 4102.2 4122.8 1263.5 1283.2 1293.1 1320.6 1421.7 16650.0 16793.7 16818.2 16837.4 16846.7 5216.8 5551.4 5570.5 5580.2 5607.5 13312.9 13338.5 13371.1 13373.7 13374.9 6335.4 6372.7 6374.2 6378.9 6379.9 4870.8 5007.6 5644.9 5677.6 5790.4 4100.0 4118.0 4229.2 4238.0 4244.0 1271.2 1273.0 1275.6 1276.1 1294.0 834.1 837.3 844.5 865.8 871.4 6247.9 6258.6 6364.7 6625.4 7048.4 892.5 896.7 902.7 904.9 907.4 3442.8 3481.9 3484.1 3535.5 3596.9 14234.4 14787.4 14814.3 14815.6 14882.9 14536.5 14595.9 14633.8 14640.3 14653.9 10127.0 10173.6 10251.4 10441.8 10444.6 6496.6 6578.4 6603.7 6626.1 6662.4 12768.2 13071.1 13143.5 13156.7 13158.6 13205.7 13222.5 13248.9 13527.7 13797.2 7478.8 7702.5 8243.7 8446.2 8454.8 9175.1 9504.0 9506.2 9508.4 9510.3 8349.7 8514.9 8540.5 8599.5 8634.0 8141.2 8142.3 8166.8 8181.3 8216.6 7338.9 7461.1 7537.7 7568.8 7576.4 5806.7 5872.6 5948.6 5961.7 6276.9 5890.6 5914.9 5933.9 5981.8 6187.9 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#4] prototype.html Cycles:180 Average:5056.35 Median:5674.33 stddev:1437.14 (25.3%) stddev-sans-first:1398.12 22:01:32 INFO - PID 1106 | Values: 404.8 412.2 415.1 426.4 436.3 5417.0 5586.6 5629.7 5729.3 5751.6 5443.8 5605.2 5610.1 5630.0 5643.3 4523.0 4535.7 4542.8 4551.2 4579.7 4403.3 4521.8 4538.8 4544.5 4592.8 4532.4 4534.2 4536.6 4554.2 4557.3 4511.3 4511.4 4528.5 4531.9 4542.9 4058.7 4117.5 4122.9 4141.6 4155.8 5513.2 5518.8 5521.2 5551.9 5577.6 5246.6 5262.9 5270.5 5276.0 5298.5 5761.4 5929.2 5953.3 5984.9 5996.4 4534.6 4540.9 4557.5 4558.4 4569.6 6118.6 6212.0 6218.4 6235.7 6239.2 4643.1 4658.1 4662.8 4668.2 4699.3 4772.2 4777.4 4781.8 4790.3 4804.0 5231.6 5243.8 5261.2 5280.2 5285.4 5690.0 5920.2 5970.4 5981.5 5993.7 1431.6 1460.1 1489.3 1536.8 1540.6 1025.5 1050.6 1064.7 1068.9 1079.5 5689.6 5693.3 5708.6 5723.3 5735.1 6013.7 6041.2 6062.7 6085.4 6091.8 5513.5 5660.2 5672.7 5675.9 5724.5 3208.6 3220.0 3220.1 3224.8 3232.7 6045.3 6241.5 6247.5 6251.4 6284.5 6130.4 6164.4 6186.8 6194.2 6196.8 6256.4 6261.7 6274.5 6278.7 6282.7 5862.0 5986.6 6040.5 6049.1 6055.5 5965.9 5986.3 5987.3 5987.7 6009.4 6055.4 6204.4 6251.2 6267.5 6275.7 4356.4 4361.3 4365.2 4371.6 4375.9 5846.0 6023.4 6056.9 6110.9 6113.0 5830.6 5915.6 5952.4 5967.3 5983.3 5945.7 5954.7 5957.2 5969.9 5971.6 5753.1 5897.8 5945.9 5952.6 5966.6 5966.7 5984.7 5993.1 5998.7 6010.5 5714.9 5786.7 5837.0 5852.3 5852.6 22:01:32 INFO - PID 1106 | 22:01:32 INFO - PID 1106 | [#5] yui.html Cycles:180 Average:16517.25 Median:20164.18 stddev:21030.23 (104.3%) stddev-sans-first:21055.38 22:01:32 INFO - PID 1106 | Values: 626.7 655.6 656.8 661.4 682.4 15073.4 15663.8 15700.2 15898.6 16359.8 14843.9 15035.8 15121.5 15192.0 15711.7 797.5 816.2 820.8 820.8 821.8 794.1 820.2 824.4 827.4 828.5 867.1 873.5 873.6 873.8 874.2 862.3 863.4 865.3 866.2 866.5 637.3 637.7 637.8 638.6 639.5 16706.0 17096.0 17155.0 17156.2 17292.2 15395.5 15489.0 15725.2 15936.0 16151.4 12035.6 12497.2 12597.4 12880.7 12913.4 3158.2 3168.2 3200.5 3240.5 3273.0 83060.0 83060.6 83406.0 84949.6 85744.6 11052.9 11213.7 11216.3 11226.4 11364.5 21260.3 21662.6 21668.2 21729.5 21867.8 8119.2 8157.2 8182.3 8271.6 8414.6 4247.9 4355.7 4363.7 4375.9 4405.3 4254.4 4348.0 4350.8 4361.1 4362.3 772.4 783.5 787.6 796.0 816.6 557.0 564.4 566.7 572.1 584.6 9858.3 9991.8 10482.0 10576.8 10577.8 568.2 568.3 570.6 571.4 578.0 4403.2 5035.2 5253.1 5301.3 5316.4 77165.0 77172.2 79211.0 79583.6 81077.0 55651.0 58008.7 69535.0 70150.0 70368.0 49789.8 50639.5 50847.5 56810.1 59032.4 9558.0 9961.9 10035.1 10115.5 10232.4 28547.4 28855.6 28952.4 29760.4 30572.4 30071.1 30799.8 35376.6 35419.3 36080.5 12824.3 12874.7 13015.2 13186.7 13229.2 13280.9 13293.7 13536.5 13561.5 14085.3 12581.0 12586.7 12972.9 13058.5 13628.2 13240.6 13799.4 13903.0 14211.6 14399.5 13188.4 13950.0 13971.7 14224.7 14389.1 10217.9 10581.7 10658.9 10798.4 11119.3 10807.0 10830.3 11402.9 11898.6 11911.9 22:01:32 INFO - PID 1106 | -------- Summary: end -------- 22:01:32 INFO - PID 1106 | 22:01:33 INFO - TEST-INFO | 1106: exit 0 22:01:33 INFO - TEST-OK | dromaeo_css | took 1118006ms 22:01:33 INFO - TEST-START | kraken 22:01:33 INFO - operating with platform_type : linux_ 22:01:33 INFO - Initialising browser for kraken test... 22:01:33 INFO - TEST-INFO | started process 1504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0IzLkE/profile http://localhost:49339/getInfo.html) 22:01:37 INFO - PID 1504 | __metrics Screen width/height:1600/1200 22:01:37 INFO - PID 1504 | colorDepth:24 22:01:37 INFO - PID 1504 | Browser inner width/height: 1024/697 22:01:37 INFO - PID 1504 | __metrics 22:01:38 INFO - PID 1504 | 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" 22:01:38 INFO - PID 1504 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:39 INFO - TEST-INFO | 1504: exit 0 22:01:39 INFO - Browser initialized. 22:01:39 INFO - Running cycle 1/1 for kraken test... 22:01:39 INFO - TEST-INFO | started process 1595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0IzLkE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:51 INFO - PID 1595 | RSS: Main: 144842752 22:01:51 INFO - PID 1595 | 22:01:53 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49339/tests/kraken/driver.html?testName=audio-beat-detection) 22:01:54 INFO - PID 1595 | RSS: Main: 199483392 22:01:54 INFO - PID 1595 | 22:01:57 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49339/tests/kraken/driver.html?testName=audio-dft) 22:01:57 INFO - PID 1595 | RSS: Main: 179855360 22:01:57 INFO - PID 1595 | 22:02:00 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49339/tests/kraken/driver.html?testName=audio-fft) 22:02:01 INFO - PID 1595 | RSS: Main: 261271552 22:02:01 INFO - PID 1595 | 22:02:03 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49339/tests/kraken/driver.html?testName=audio-oscillator) 22:02:04 INFO - PID 1595 | RSS: Main: 171683840 22:02:04 INFO - PID 1595 | 22:02:06 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:02:06 INFO - PID 1595 | RSS: Main: 176115712 22:02:06 INFO - PID 1595 | 22:02:09 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49339/tests/kraken/driver.html?testName=imaging-darkroom) 22:02:10 INFO - PID 1595 | RSS: Main: 215330816 22:02:10 INFO - PID 1595 | 22:02:13 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49339/tests/kraken/driver.html?testName=imaging-desaturate) 22:02:14 INFO - PID 1595 | RSS: Main: 231575552 22:02:14 INFO - PID 1595 | 22:02:17 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49339/tests/kraken/driver.html?testName=json-parse-financial) 22:02:17 INFO - PID 1595 | RSS: Main: 247918592 22:02:17 INFO - PID 1595 | 22:02:19 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:02:20 INFO - PID 1595 | RSS: Main: 177209344 22:02:20 INFO - PID 1595 | 22:02:21 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:02:22 INFO - PID 1595 | RSS: Main: 183721984 22:02:22 INFO - PID 1595 | 22:02:24 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:02:25 INFO - PID 1595 | RSS: Main: 193753088 22:02:25 INFO - PID 1595 | 22:02:27 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:02:28 INFO - PID 1595 | RSS: Main: 202657792 22:02:28 INFO - PID 1595 | 22:02:31 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:02:32 INFO - PID 1595 | RSS: Main: 200601600 22:02:32 INFO - PID 1595 | 22:02:33 INFO - PID 1595 | Cycle 1(1): loaded http://localhost:49339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49339/tests/kraken/driver.html?testName=ai-astar) 22:02:34 INFO - PID 1595 | RSS: Main: 268935168 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | __start_tp_report 22:02:34 INFO - PID 1595 | _x_x_mozilla_page_load 22:02:34 INFO - PID 1595 | _x_x_mozilla_page_load_details 22:02:34 INFO - PID 1595 | |i|pagename|runs| 22:02:34 INFO - PID 1595 | |0;ai-astar;101;108;110;108;110;109;109;109;109;109 22:02:34 INFO - PID 1595 | |1;audio-beat-detection;148;118;124;163;122;118;120;118;150;119 22:02:34 INFO - PID 1595 | |2;audio-dft;163;161;163;161;163;162;161;162;162;162 22:02:34 INFO - PID 1595 | |3;audio-fft;74;73;75;116;75;76;76;74;94;84 22:02:34 INFO - PID 1595 | |4;audio-oscillator;84;83;105;84;85;84;106;95;84;106 22:02:34 INFO - PID 1595 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;114;113;113 22:02:34 INFO - PID 1595 | |6;imaging-darkroom;147;147;147;146;147;147;147;148;147;147 22:02:34 INFO - PID 1595 | |7;imaging-desaturate;94;94;94;95;95;94;94;95;94;94 22:02:34 INFO - PID 1595 | |8;json-parse-financial;59;58;57;57;60;61;62;62;58;58 22:02:34 INFO - PID 1595 | |9;json-stringify-tinderbox;56;56;55;55;56;55;55;56;55;55 22:02:34 INFO - PID 1595 | |10;stanford-crypto-aes;81;80;80;81;79;88;79;81;82;80 22:02:34 INFO - PID 1595 | |11;stanford-crypto-ccm;138;127;129;126;124;127;127;129;170;126 22:02:34 INFO - PID 1595 | |12;stanford-crypto-pbkdf2;182;183;184;184;186;181;188;185;186;183 22:02:34 INFO - PID 1595 | |13;stanford-crypto-sha256-iterative;66;64;67;67;66;65;67;64;65;65 22:02:34 INFO - PID 1595 | __end_tp_report 22:02:34 INFO - PID 1595 | __start_cc_report 22:02:34 INFO - PID 1595 | _x_x_mozilla_cycle_collect,1755 22:02:34 INFO - PID 1595 | __end_cc_report 22:02:34 INFO - PID 1595 | __startTimestamp1490158954020__endTimestamp 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | ------- Summary: start ------- 22:02:34 INFO - PID 1595 | Number of tests: 14 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.62 (2.4%) stddev-sans-first:0.71 22:02:34 INFO - PID 1595 | Values: 101.0 108.0 110.0 108.0 110.0 109.0 109.0 109.0 109.0 109.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:123.00 stddev:16.89 (13.7%) stddev-sans-first:16.61 22:02:34 INFO - PID 1595 | Values: 148.0 118.0 124.0 163.0 122.0 118.0 120.0 118.0 150.0 119.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 22:02:34 INFO - PID 1595 | Values: 163.0 161.0 163.0 161.0 163.0 162.0 161.0 162.0 162.0 162.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.67 (18.1%) stddev-sans-first:14.21 22:02:34 INFO - PID 1595 | Values: 74.0 73.0 75.0 116.0 75.0 76.0 76.0 74.0 94.0 84.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:10.30 (12.3%) stddev-sans-first:10.55 22:02:34 INFO - PID 1595 | Values: 84.0 83.0 105.0 84.0 85.0 84.0 106.0 95.0 84.0 106.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:02:34 INFO - PID 1595 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:02:34 INFO - PID 1595 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:02:34 INFO - PID 1595 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:1.93 (3.2%) stddev-sans-first:2.05 22:02:34 INFO - PID 1595 | Values: 59.0 58.0 57.0 57.0 60.0 61.0 62.0 62.0 58.0 58.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 22:02:34 INFO - PID 1595 | Values: 56.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 55.0 55.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.60 (3.2%) stddev-sans-first:2.76 22:02:34 INFO - PID 1595 | Values: 81.0 80.0 80.0 81.0 79.0 88.0 79.0 81.0 82.0 80.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:128.00 stddev:13.78 (10.8%) stddev-sans-first:14.46 22:02:34 INFO - PID 1595 | Values: 138.0 127.0 129.0 126.0 124.0 127.0 127.0 129.0 170.0 126.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:184.50 stddev:2.10 (1.1%) stddev-sans-first:2.07 22:02:34 INFO - PID 1595 | Values: 182.0 183.0 184.0 184.0 186.0 181.0 188.0 185.0 186.0 183.0 22:02:34 INFO - PID 1595 | 22:02:34 INFO - PID 1595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 22:02:34 INFO - PID 1595 | Values: 66.0 64.0 67.0 67.0 66.0 65.0 67.0 64.0 65.0 65.0 22:02:34 INFO - PID 1595 | -------- Summary: end -------- 22:02:34 INFO - PID 1595 | 22:02:35 INFO - TEST-INFO | 1595: exit 0 22:02:35 INFO - TEST-OK | kraken | took 62051ms 22:02:35 INFO - SUITE-END | took 1180s 22:02:35 INFO - Completed test suite (00:19:40) 22:02:35 INFO - javascript benchmark 22:02:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7420.973322562354, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.4448743713565, 3287.5233091201776, 3308.3714094322063, 3318.4192766265896, 3342.348242092791, 5691.4024027477035, 5709.200711900332, 5738.713064346782, 5764.711764411783, 5795.594308398403, 5817.505512031483, 5824.941750582493, 5837.270341207349, 5870.735816888239, 5874.001419758641, 5105.132127538309, 5170.663906846053, 5178.559822415081, 5269.077911365515, 5352.437994010631, 5246.685198888079, 5256.684598924076, 5318.202269659543, 5324.494173053554, 5335.7332133393365, 5085.923711144317, 5137.3064636274, 5150.150225212854, 5207.739613019334, 5228.4510126436935, 5226.660267082628, 5244.318238628954, 5259.8422047338645, 5294.205869119624, 5328.573714102862, 5197.870053248661, 5247.291615631879, 5276.261323414725, 5278.551323137538, 5279.577633789288, 5627.380988091307, 5736.139579063132, 5753.539716822645, 5818.738156782955, 5856.882862342729, 6098.644029113934, 6194.938050619481, 6261.279952805395, 6264.966280563747, 6270.749170033193, 6201.751929922798, 6228.190335256433, 6229.595076320024, 6230.252369715663, 6236.844078898019, 5711.971440142773, 5756.107803290497, 5765.308163020422, 5775.971120144414, 5811.0, 6213.844653883689, 6296.716647750863, 6301.117843501914, 6340.841478963062, 6352.523560732963, 5883.588148829626, 5937.168796368512, 5941.168236446901, 5950.256217972754, 6176.6911654418, 6067.0, 6101.435748753901, 6103.337669688843, 6111.257501106225, 6114.388610881752, 6122.86583998841, 6123.414962257987, 6129.09499847894, 6131.296552205817, 6136.182108626252, 6123.28262147438, 6123.608950580373, 6127.903150210862, 6140.854922927007, 6148.231471066117, 4642.605378542794, 4690.9765451172525, 4736.763161841963, 4751.3348131261655, 4762.476127625959, 4198.0, 4215.978920105441, 4231.640310573635, 4243.42713733642, 4253.680973926967, 5817.912731309034, 5834.299884013861, 5835.503982161479, 5859.941400586024, 5887.5289976802605, 6019.277686677539, 6110.419510146529, 6263.937360626426, 6269.216347956505, 6339.556231063873, 5870.3249126350165, 5904.7342869570975, 5930.733117009659, 5951.166836642873, 5964.671943043088, 5325.813596524103, 5350.8662283442445, 5352.5450336721815, 5357.7589008494715, 5358.276632654542, 6282.685865706788, 6544.3782840630065, 6562.704678289393, 6563.310852360433, 6575.901361479581, 6123.050927106306, 6239.625622462667, 6248.0940263660605, 6258.749650013949, 6304.936950630435, 6487.3836985486305, 6553.311902250195, 6557.049227862029, 6563.343665633399, 6563.540552161494, 6199.56603037783, 6207.068939659087, 6208.534359923115, 6222.751089956351, 6233.252009758858, 6003.90994135097, 6097.524678803442, 6230.626162430088, 6286.402791734778, 6292.370762923671, 6061.575689701678, 6063.8180854572665, 6066.787662431793, 6067.635941843327, 6112.602680825732, 5936.198613187337, 6001.399860013964, 6039.335673076046, 6042.788502402394, 6055.636661800306, 5878.088896221093, 5919.467247947706, 5924.6149000314845, 5932.555058370725, 5947.405259474191, 5955.880882382415, 5982.282126144716, 5982.790602329072, 5988.6107403020405, 5996.610220335839, 5816.331121921034, 5841.386654401226, 5843.912341314799, 5844.707764611838, 5846.970765146147], "value": 5695.8324205700565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.3320812958589, 711.2425267090548, 730.3864753606971, 1082.4209048159237, 1107.186218129674, 28586.428271434557, 35482.822585887065, 36179.63820361796, 36228.0, 36253.81873090631, 39311.0, 39831.62273093132, 39851.20297594046, 39853.0, 39892.80053599728, 5957.9404205958035, 6100.176476175704, 7877.960610196956, 8063.758087257392, 8074.838503229932, 7623.466357354987, 7768.300852923236, 7770.456068075208, 7772.727954521592, 7780.260875216845, 7756.457048006641, 7833.804154896116, 7836.0, 7839.843203135933, 7843.372530197599, 7697.3457256133015, 7794.961025194894, 7805.024371953506, 7808.570528620923, 7851.842963140763, 7916.247956444128, 8187.918120818775, 8188.590570471452, 8191.0580283267, 8197.0, 40423.59576404228, 40799.7960010201, 40844.18311633751, 40903.38644920329, 40916.79541602303, 3016.7737419693613, 3036.6052413186144, 3047.131567503251, 3073.585066016104, 3107.704768047032, 28313.57529637057, 28322.02618725025, 28459.57310640342, 28785.136445906657, 29739.553906691417, 3471.3925063114107, 3535.8762443314617, 3546.148924258185, 3568.2863427314383, 3606.6393360663724, 202060.0, 203343.0, 203514.0, 204495.0, 204681.97659011759, 49235.0, 49521.50478495169, 49606.751966239935, 49621.25568116481, 49637.25544116841, 51432.22851657228, 51558.48441515537, 51600.741996290526, 51651.483485165416, 51698.48301516937, 14697.338619762137, 14983.250837458301, 14991.175485348193, 14996.625084372978, 14998.400063997318, 9511.57197926095, 9664.806703865883, 10891.0, 11992.400379980965, 12026.873013016504, 13387.464501419834, 13414.798778018338, 13450.461981520826, 13456.259905705085, 13518.729625407437, 5422.457754224546, 5453.863653408696, 5481.150421684645, 5487.451254874481, 5661.886762264731, 1017.2421545948316, 1017.9083882450467, 1036.3212096076932, 1038.9584416623402, 1039.293280569205, 24309.0, 24410.145644902343, 24511.509769804503, 24518.264452066465, 24559.0, 1106.4910141334915, 1111.2054880760295, 1144.2333636463588, 1148.7817314710346, 1156.7108222944264, 12148.271103733805, 12808.743825123445, 12891.548795792101, 12944.482220711066, 12960.935195324151, 303518.0, 304046.0, 304297.0, 304435.0, 304612.0, 53585.46414535805, 53883.461165387846, 53948.73025634847, 54069.45930540723, 54147.18779218315, 1450.8839292856546, 1474.0639693794517, 1496.453794365049, 1501.909885406879, 1511.5389806109242, 23182.0, 23926.12886453567, 23967.880160599085, 24123.75876241215, 24219.152329669083, 39493.40759888547, 43155.568444316414, 43810.342844856714, 43920.78039609781, 44085.0, 199365.0, 199870.0, 200117.0, 200518.0, 200617.0, 26634.334141646614, 26696.733032669425, 27139.185824425298, 28573.285602863896, 29539.0, 39658.0, 39810.40284395794, 39953.40069899012, 40049.59950400459, 40148.19703605853, 33494.330113398086, 33874.49188262227, 34214.0, 34349.14127146841, 34418.31163376669, 33140.17149571184, 33248.0, 33298.0, 33981.49027764536, 34404.0, 34487.4826877602, 35019.47470787991, 35897.820510897276, 35947.46078808768, 35951.820240898625, 25647.87176064108, 28495.43009139764, 28550.143495695163, 28597.85701071481, 28963.131106066852, 23681.17115900935, 24179.578863726238, 24328.1485148019, 24570.87714561416, 24876.50246995086], "value": 16850.393313746852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.4482507215834, 442.32103720788575, 444.5909763018023, 462.29500012480986, 462.7269910752655, 18545.258189672415, 19832.0, 20236.797632023674, 20424.795752042475, 21868.0, 21574.676379854314, 21941.451463713416, 22445.653260804324, 22655.20706775263, 22706.659400109012, 5773.653580785166, 5885.146653735206, 5936.762529498815, 5936.792212272571, 5940.465358117768, 5542.806001789938, 5907.704614769265, 5946.583739138262, 5950.672713000783, 5954.642721436728, 5808.941910580882, 5915.112733090028, 5916.615419997708, 5917.792877249297, 5920.082387229986, 5778.913316300259, 5805.7387417566315, 5826.242588463515, 5843.328017278025, 5844.853878653025, 5245.632805703603, 5262.8684282892855, 5302.443243459458, 5305.4164041955355, 5310.787568497255, 25942.870285648452, 25949.351266218306, 26210.737892621022, 26218.0, 26231.73768262312, 2001.8898960557165, 2006.1273346094495, 2008.8794672319561, 2024.5950809837943, 2033.1359172351692, 15465.989421375261, 15725.0, 15837.287322070535, 15936.442224522087, 16655.083970381624, 1894.4884881082169, 1904.0, 1912.837408820252, 1920.5294702797903, 1926.7398901148306, 98267.50866245695, 98559.0, 99530.0, 100002.49998750033, 101988.49005754924, 12239.0, 12271.69320766988, 12323.815142772866, 12389.132760706663, 12674.514508510234, 17644.382446614305, 17667.0, 17672.0, 17674.116294185496, 17681.823181768017, 8793.912060879436, 9065.274778017743, 9097.636094556276, 9131.406458580172, 9218.216451601555, 8290.544020078833, 8340.165983401612, 8377.287930525852, 8595.699150529827, 8601.440906341068, 7531.698732050657, 7574.166841647414, 7738.845223095506, 7768.961155194301, 7846.215378462108, 2221.622324204889, 2226.2208227120377, 2264.4904896398507, 2289.2674344209695, 2295.3114065780533, 1000.6347683095618, 1006.5872992073215, 1026.9691909242736, 1029.763154474475, 1036.5744158668601, 19656.410307690792, 20188.293409730588, 20262.493437664176, 20414.89792551028, 20436.28473003438, 1069.550788668761, 1069.5775168808277, 1080.7190130565953, 1088.9074428673493, 1089.7221208591916, 10861.07680847121, 12176.0, 13119.803202951773, 13329.66675833112, 13420.865791342158, 308199.0, 499257.0, 661371.0, 689766.0, 699913.0, 113556.0, 113955.0, 115318.0, 118622.76526816837, 119069.0, 1250.6185613388004, 1285.4665313894816, 1291.109134697056, 1299.5971248912867, 1302.8892544133664, 20049.59900802005, 20307.492312692302, 20863.0, 20958.685619715412, 21104.15583376709, 48046.5195348056, 49050.26424603562, 50212.49787502078, 50255.06515007217, 50755.492445076554, 65957.67021165055, 66624.6668766653, 67022.3297767016, 67478.66260668666, 67720.0, 8767.473951562926, 9018.278537716837, 9130.726078217664, 9218.170364667212, 9324.580393882155, 13439.932800335935, 13581.45674173022, 13651.180929144282, 13751.587452376445, 13851.238181900093, 10834.837477438003, 11456.82814757796, 11586.71033224176, 12069.57756478519, 12290.569830055905, 11701.0, 11741.354225517678, 11754.412279386168, 12166.330851803235, 12345.321007344683, 11740.0, 11916.16586838913, 12107.33409662477, 12845.42195601219, 13026.28355440422, 12268.386580670753, 13056.543020994219, 13572.79640805369, 13781.655458613615, 14133.15201087938, 12752.936235318764, 12780.488780448677, 12817.23096614206, 12973.805392918925, 13149.079564430398], "value": 10358.254740594539, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.4797089280721, 1322.4313545175573, 1346.521984695433, 1382.4884792626724, 1396.6717821311993, 9144.0, 10474.0, 10854.294470859388, 10903.0, 10910.018098371145, 10603.0, 10628.468576571178, 10654.680359589205, 10664.30682005671, 10681.465926703653, 1860.5906700525863, 1922.2695375757194, 2326.7091613548264, 2369.6327069304284, 2374.620060790274, 2348.8708121053337, 2387.77316154965, 2392.497575509145, 2396.125414223813, 2415.6014257647466, 2350.5416443793383, 2363.8581685098948, 2367.822413318999, 2369.917052903149, 2370.5495955768433, 2373.976260237401, 2376.3346263046374, 2376.3940195250275, 2379.928602141921, 2389.3190440724484, 2125.543008253233, 2136.198925402974, 2161.6325224711836, 2161.8054375106317, 2164.794344537282, 10780.622678206226, 10884.564617415293, 10891.564337426493, 10897.455127243606, 10912.345259284468, 6093.542984276197, 6268.592541484834, 6283.654399008053, 6302.621842689453, 6308.653024083674, 3815.3895376739865, 3939.9962048198627, 4059.2490389278078, 4102.220578090153, 4122.835086596532, 1263.456713613146, 1283.2364742977913, 1293.1012946002531, 1320.610419926124, 1421.6588018875498, 16650.0, 16793.748093778602, 16818.243179056848, 16837.410690625893, 16846.747298790404, 5216.817411390583, 5551.361593416728, 5570.470805273492, 5580.190872323572, 5607.495325420732, 13312.933435332956, 13338.533151339656, 13371.06402551812, 13373.732525349438, 13374.866251337362, 6335.36646335372, 6372.7132279047555, 6374.203224596926, 6378.936210637834, 6379.904301435482, 4870.756462176948, 5007.624428167829, 5644.887102258014, 5677.574181936288, 5790.449907258803, 4100.0, 4117.982684626989, 4229.175310814362, 4237.978810105929, 4243.957560424418, 1271.167385362589, 1272.961811145667, 1275.5981865712272, 1276.113101394522, 1293.9741205175844, 834.0950069175013, 837.2799392522426, 844.5481667307961, 865.8051938313829, 871.3987348729356, 6247.875042499125, 6258.561900667, 6364.681765911686, 6625.4037136657935, 7048.436125109979, 892.4868200784575, 896.7221709064687, 902.7427183252742, 904.9095090490898, 907.4056492997097, 3442.759006869495, 3481.9129521762156, 3484.1115515543374, 3535.524456034865, 3596.928061438809, 14234.359453824603, 14787.408503659948, 14814.259287035606, 14815.555533334018, 14882.925585372004, 14536.491222807152, 14595.85404145945, 14633.780493292608, 14640.341184646717, 14653.853461465462, 10127.0, 10173.593056277667, 10251.436171010666, 10441.791164176673, 10444.582216711398, 6496.642684652389, 6578.375054370019, 6603.702833372606, 6626.072349870926, 6662.433693136138, 12768.170068945488, 13071.085024048225, 13143.474261029452, 13156.671083222996, 13158.60524184276, 13205.735885282433, 13222.537211197561, 13248.867511324763, 13527.72944541084, 13797.172169669851, 7478.813029674302, 7702.499337543042, 8243.711470098759, 8446.197611226924, 8454.83090338202, 9175.128362805523, 9504.0, 9506.239500839778, 9508.381955172892, 9510.334276600572, 8349.666013359398, 8514.872276915976, 8540.487570745776, 8599.52702601363, 8633.95683021581, 8141.22658347456, 8142.3486121111355, 8166.754997350089, 8181.304589109992, 8216.589170541569, 7338.926610734038, 7461.104667439942, 7537.698492060256, 7568.772936811904, 7576.393888489018, 5806.65160090396, 5872.559558033079, 5948.643081415129, 5961.672108034099, 6276.905846412216, 5890.558208134321, 5914.911276330945, 5933.910991335047, 5981.760729570942, 6187.876242475035], "value": 5168.409145262592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.7834408591404, 412.1591952417069, 415.13444468283626, 426.4307149954809, 436.25836078666254, 5417.0, 5586.581006424514, 5629.746661400237, 5729.312482502106, 5751.626144300618, 5443.782248710057, 5605.159226116085, 5610.13042978338, 5630.0, 5643.294588176478, 4522.977385113069, 4535.682502224846, 4542.750148741818, 4551.180787458256, 4579.725216487005, 4403.273459879116, 4521.819127234907, 4538.795754191053, 4544.500104988449, 4592.839250626229, 4532.3654688343495, 4534.229181039232, 4536.591706746392, 4554.157480866051, 4557.313793896246, 4511.338310396849, 4511.436070491189, 4528.479224889131, 4531.934995276108, 4542.88699268678, 4058.715889887709, 4117.505899292074, 4122.9381559276635, 4141.6065473780245, 4155.771432571208, 5513.173024046385, 5518.779248830042, 5521.2270282160525, 5551.945780061363, 5577.637453565546, 5246.554042906358, 5262.8684282892855, 5270.499302566289, 5276.0, 5298.536180675966, 5761.366249712528, 5929.169916211734, 5953.2856057272975, 5984.8503787405225, 5996.370381109964, 4534.6372290216705, 4540.909181816378, 4557.453105627313, 4558.407407037064, 4569.634429245685, 6118.632882027093, 6211.9999999999545, 6218.440340369343, 6235.688215589203, 6239.188905442264, 4643.094596553639, 4658.114958157939, 4662.790174442158, 4668.159731248408, 4699.295105734167, 4772.188727916263, 4777.355057067251, 4781.808727650925, 4790.305405716152, 4804.0, 5231.581473482112, 5243.842684719464, 5261.210818377274, 5280.20796880471, 5285.432333175091, 5690.0, 5920.230370051866, 5970.432808883149, 5981.491573216325, 5993.670348130895, 1431.591996281055, 1460.1458146984132, 1489.3446883371282, 1536.8155821301516, 1540.5686407805833, 1025.477006726575, 1050.5850189175233, 1064.6912395405245, 1068.871735391758, 1079.5034284229184, 5689.573282003867, 5693.345265294462, 5708.600397972185, 5723.341815691166, 5735.139729040678, 6013.6692481913915, 6041.214642096499, 6062.666553339609, 6085.36103709113, 6091.751191005833, 5513.5037846594, 5660.235868157828, 5672.744726487318, 5675.914861277084, 5724.484796368347, 3208.598925134358, 3219.9535151075993, 3220.146661134801, 3224.7903886247786, 3232.725218356466, 6045.304789949124, 6241.500679945593, 6247.531435142382, 6251.437370636573, 6284.465820405317, 6130.448259656652, 6164.4143806338325, 6186.783462578788, 6194.163787888668, 6196.845078872974, 6256.436920677161, 6261.655608941552, 6274.486287678915, 6278.717457714505, 6282.748690052438, 5862.0, 5986.610870293417, 6040.516758659384, 6049.122877182695, 6055.5458340623745, 5965.940340596539, 5986.281646202484, 5987.251593550806, 5987.730552125077, 6009.36901625323, 6055.424734650202, 6204.3795620437595, 6251.218207897442, 6267.46726528232, 6275.6862156892885, 4356.390105385185, 4361.323994780814, 4365.192439398721, 4371.584699453547, 4375.934360984652, 5846.035404158266, 6023.427774361428, 6056.942453051751, 6110.938890611037, 6113.0, 5830.62100963436, 5915.615484993462, 5952.375000624872, 5967.254093238345, 5983.311919129356, 5945.672987985529, 5954.702264886825, 5957.225560677258, 5969.910451343147, 5971.552133589911, 5753.1370294456165, 5897.823065308047, 5945.91081133792, 5952.553558483044, 5966.552508561788, 5966.731497082555, 5984.730687119003, 5993.101034844808, 5998.70006499682, 6010.549208809444, 5714.9142762857755, 5786.652800831964, 5836.978528757366, 5852.297724273115, 5852.600433822113], "value": 4611.849284577161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.6897885546649, 655.5902560899438, 656.781670002146, 661.4212564006493, 682.3517658224687, 15073.397064117422, 15663.765043524329, 15700.214989250535, 15898.602534936632, 16359.83640163598, 14843.92578037111, 15035.849641503582, 15121.470748523803, 15192.0, 15711.685766284667, 797.5214871077351, 816.163432481708, 820.7906983719143, 820.7989042684551, 821.8191997760483, 794.0947320055113, 820.1675299570941, 824.3899514359391, 827.4125370986607, 828.5194587139445, 867.0982178534317, 873.5457562067721, 873.5763154869883, 873.829603227371, 874.152072489684, 862.258457726358, 863.3826813828143, 865.3466632692308, 866.2117473099512, 866.5407334112899, 637.3021541412146, 637.6939069246741, 637.7959053103009, 638.594492497263, 639.4788247578209, 16706.0, 17096.0, 17154.99787537176, 17156.227969741267, 17292.22185001678, 15395.461158859498, 15489.0, 15725.191602965691, 15936.0, 16151.434699785452, 12035.57875474363, 12497.18768280059, 12597.433115509824, 12880.742385152245, 12913.418896149697, 3158.178873492908, 3168.17627416871, 3200.519922011694, 3240.5301231321564, 3273.018094571619, 83060.0, 83060.58469707673, 83406.0, 84949.57525212334, 85744.57127714384, 11052.944735276273, 11213.71965700864, 11216.327020378803, 11226.438678066064, 11364.48859801311, 21260.25589104374, 21662.566748665253, 21668.24161154352, 21729.45676358072, 21867.781322186893, 8119.228673276029, 8157.184281571914, 8182.345412366996, 8271.627776750061, 8414.621342039623, 4247.893802654959, 4355.673324500675, 4363.716358436755, 4375.890602734893, 4405.273129933525, 4254.446921900195, 4348.043430445297, 4350.760708161019, 4361.1495758327455, 4362.280223763107, 772.3743767548303, 783.475071701961, 787.5550314072531, 796.0248695348267, 816.5631387207816, 556.9610127291131, 564.4186487917369, 566.6854895533019, 572.0503963420701, 584.5878655547829, 9858.276672270486, 9991.755153029357, 10482.0, 10576.788464230825, 10577.788444231071, 568.2357229526281, 568.3208565763872, 570.5549671256426, 571.3914680864866, 577.982660520185, 4403.207422663952, 5035.219540971156, 5253.133233016586, 5301.310829592206, 5316.362036555638, 77165.0, 77172.22827771763, 79211.0, 79583.60208198921, 81077.0, 55651.0, 58008.709956449944, 69535.0, 70150.0, 70368.0, 49789.751051244515, 50639.49360506421, 50847.491525084275, 56810.14784778232, 59032.40967590441, 9558.0, 9961.850572241277, 10035.09684128432, 10115.494225288854, 10232.386056836614, 28547.42905141927, 28855.5671664921, 28952.420951581273, 29760.40479190361, 30572.388552229277, 30071.09786706402, 30799.846000769852, 35376.646233537336, 35419.29161416706, 36080.45879311865, 12824.29466379358, 12874.67813304675, 13015.219086854819, 13186.736265274832, 13229.206247625174, 13280.867191327963, 13293.66765830862, 13536.458541658223, 13561.457541698615, 14085.295735212994, 12581.0, 12586.685332866386, 12972.935135324264, 13058.477660893837, 13628.182309061489, 13240.602781916557, 13799.448022079005, 13903.0, 14211.64470888236, 14399.496017639332, 13188.406521706738, 13950.0, 13971.650708732363, 14224.715505690036, 14389.064710793766, 10217.897821021694, 10581.735456613646, 10658.946705266424, 10798.35390946502, 11119.277246979244, 10807.0, 10830.296030757976, 11402.885971140515, 11898.643040708792, 11911.940440297743], "value": 7047.689657357546, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 110.0, 108.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 124.0, 163.0, 122.0, 118.0, 120.0, 118.0, 150.0, 119.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 163.0, 162.0, 161.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 116.0, 75.0, 76.0, 76.0, 74.0, 94.0, 84.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 84.0, 85.0, 84.0, 106.0, 95.0, 84.0, 106.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 57.0, 60.0, 61.0, 62.0, 62.0, 58.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 81.0, 79.0, 88.0, 79.0, 81.0, 82.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 127.0, 129.0, 126.0, 124.0, 127.0, 127.0, 129.0, 170.0, 126.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 184.0, 186.0, 181.0, 188.0, 185.0, 186.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 67.0, 66.0, 65.0, 67.0, 64.0, 65.0, 65.0], "value": 65.6, "unit": "score"}]}]} 22:02:35 INFO - Return code: 0 22:02:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:02:35 ERROR - # TBPL SUCCESS # 22:02:35 INFO - Running post-action listener: _resource_record_post_action 22:02:35 INFO - [mozharness: 2017-03-22 05:02:35.333450Z] Finished run-tests step (success) 22:02:35 INFO - Running post-run listener: _resource_record_post_run 22:02:35 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370425856; Read time: 8; Write time: 422940 22:02:35 INFO - TinderboxPrint: CPU usage
12.9% 22:02:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:02:35 INFO - TinderboxPrint: I/O write bytes / time
370,425,856 / 422,940 22:02:35 INFO - TinderboxPrint: CPU idle
8,318.0 (87.1%) 22:02:35 INFO - TinderboxPrint: CPU user
1,186.6 (12.4%) 22:02:35 INFO - TinderboxPrint: Swap in / out
0 / 0 22:02:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116482048; Read time: 0; Write time: 151444 22:02:35 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 253546496; Read time: 0; Write time: 271432 22:02:35 INFO - Running post-run listener: _upload_blobber_files 22:02:35 INFO - Blob upload gear active. 22:02:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:02:35 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 22:02:35 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:02:35 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:02:36 INFO - (blobuploader) - INFO - Open directory for files ... 22:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:37 INFO - (blobuploader) - INFO - Done attempting. 22:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:38 INFO - (blobuploader) - INFO - Done attempting. 22:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:02:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:41 INFO - (blobuploader) - INFO - Done attempting. 22:02:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:02:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:41 INFO - (blobuploader) - INFO - Done attempting. 22:02:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:02:41 INFO - Return code: 0 22:02:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:02:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:02:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57a304b0cfacd77eb413fc9dd31722be7b051b29e574895b7e4a0f88942baa3061220128bc9536a5f9bf00b68525bd7eae3f9f1447fe188e8b6ab937a325154c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27f9f7f6d0bb53c4d5cc324617324e7850008debd9e019fc9bcee075f8a5eb775ebb2e5e5b649b71a1db6ac4d0a45fb01e5835d6a9a1750c698fff05f158888c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/811b1c350e22ebde932ede929abe712f58e81cad3732f44c30415a631b03fda9db49931ca22d965cef16c3c91c4989da559a3b38fbd7eed92d0c9347abc5d4b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ef374bf58e6790b8964efa0a95721a5771e15a97eab4d8434fafcefd2e4932f2c207ea92ef305a228bdec5a66a7a42723ca5785cc6cc0667a210e070fe5ec5"} 22:02:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:02:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:02:41 INFO - Contents: 22:02:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57a304b0cfacd77eb413fc9dd31722be7b051b29e574895b7e4a0f88942baa3061220128bc9536a5f9bf00b68525bd7eae3f9f1447fe188e8b6ab937a325154c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27f9f7f6d0bb53c4d5cc324617324e7850008debd9e019fc9bcee075f8a5eb775ebb2e5e5b649b71a1db6ac4d0a45fb01e5835d6a9a1750c698fff05f158888c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/811b1c350e22ebde932ede929abe712f58e81cad3732f44c30415a631b03fda9db49931ca22d965cef16c3c91c4989da559a3b38fbd7eed92d0c9347abc5d4b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ef374bf58e6790b8964efa0a95721a5771e15a97eab4d8434fafcefd2e4932f2c207ea92ef305a228bdec5a66a7a42723ca5785cc6cc0667a210e070fe5ec5"} 22:02:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:02:41 INFO - Copying logs to upload dir... 22:02:41 INFO - mkdir: /builds/slave/test/build/upload/logs 22:02:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.308548 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-03-21 22:02:41.450199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 22:02:41.453555) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 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/sha512/57a304b0cfacd77eb413fc9dd31722be7b051b29e574895b7e4a0f88942baa3061220128bc9536a5f9bf00b68525bd7eae3f9f1447fe188e8b6ab937a325154c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27f9f7f6d0bb53c4d5cc324617324e7850008debd9e019fc9bcee075f8a5eb775ebb2e5e5b649b71a1db6ac4d0a45fb01e5835d6a9a1750c698fff05f158888c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/811b1c350e22ebde932ede929abe712f58e81cad3732f44c30415a631b03fda9db49931ca22d965cef16c3c91c4989da559a3b38fbd7eed92d0c9347abc5d4b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ef374bf58e6790b8964efa0a95721a5771e15a97eab4d8434fafcefd2e4932f2c207ea92ef305a228bdec5a66a7a42723ca5785cc6cc0667a210e070fe5ec5"} build_url:https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/B-U5U7jLRKWEIoSkVqdS_A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57a304b0cfacd77eb413fc9dd31722be7b051b29e574895b7e4a0f88942baa3061220128bc9536a5f9bf00b68525bd7eae3f9f1447fe188e8b6ab937a325154c", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27f9f7f6d0bb53c4d5cc324617324e7850008debd9e019fc9bcee075f8a5eb775ebb2e5e5b649b71a1db6ac4d0a45fb01e5835d6a9a1750c698fff05f158888c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/811b1c350e22ebde932ede929abe712f58e81cad3732f44c30415a631b03fda9db49931ca22d965cef16c3c91c4989da559a3b38fbd7eed92d0c9347abc5d4b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43ef374bf58e6790b8964efa0a95721a5771e15a97eab4d8434fafcefd2e4932f2c207ea92ef305a228bdec5a66a7a42723ca5785cc6cc0667a210e070fe5ec5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 22:02:41.477988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:02:41.478308) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1490157691.725409-1424698205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 22:02:41.560659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 22:02:41.560950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 22:02:41.561241) ========= ========= Total master_lag: 0.14 =========