builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1491841688.06 results: success (0) revision: 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.055513) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.055956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.056244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.080669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.081034) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 09:28:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-04-10 09:28:08 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.245010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.245323) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076069 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:08.332944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 09:28:08.333282) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 --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=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 09:28:08,526 truncating revision to first 12 chars 2017-04-10 09:28:08,526 Setting DEBUG logging. 2017-04-10 09:28:08,527 attempt 1/10 2017-04-10 09:28:08,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/718da6d0b0bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 09:28:09,642 unpacking tar archive at: mozilla-aurora-718da6d0b0bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.502942 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 09:28:09.850499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:09.850813) ========= script_repo_revision: 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:09.851177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:09.851454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 09:28:09.861378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-10 09:28:09.861683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:10 INFO - MultiFileLogger online at 20170410 09:28:10 in /builds/slave/test 09:28:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:28:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:10 INFO - {'append_to_log': False, 09:28:10 INFO - 'base_work_dir': '/builds/slave/test', 09:28:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:28:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:10 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:28:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:10 INFO - 'config_files': ('talos/linux_config.py',), 09:28:10 INFO - 'default_actions': ('clobber', 09:28:10 INFO - 'read-buildbot-config', 09:28:10 INFO - 'download-and-extract', 09:28:10 INFO - 'populate-webroot', 09:28:10 INFO - 'create-virtualenv', 09:28:10 INFO - 'install', 09:28:10 INFO - 'run-tests'), 09:28:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:10 INFO - 'download_minidump_stackwalk': True, 09:28:10 INFO - 'download_symbols': 'ondemand', 09:28:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:10 INFO - 'gecko_profile': False, 09:28:10 INFO - 'gecko_profile_interval': 0, 09:28:10 INFO - 'installer_path': 'installer.exe', 09:28:10 INFO - 'log_level': 'info', 09:28:10 INFO - 'log_name': 'talos', 09:28:10 INFO - 'log_to_console': True, 09:28:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:10 INFO - 'opt_config_files': (), 09:28:10 INFO - 'pip_index': False, 09:28:10 INFO - 'suite': 'dromaeojs-e10s', 09:28:10 INFO - 'system_bits': '32', 09:28:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:10 INFO - 'title': 'talos-linux64-ix-012', 09:28:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:10 INFO - 'use_talos_json': True, 09:28:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:10 INFO - 'work_dir': 'build'} 09:28:10 INFO - [mozharness: 2017-04-10 16:28:10.245553Z] Running clobber step. 09:28:10 INFO - Running pre-action listener: _resource_record_pre_action 09:28:10 INFO - Running main action method: clobber 09:28:10 INFO - rmtree: /builds/slave/test/build 09:28:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:12 INFO - Running post-action listener: _resource_record_post_action 09:28:12 INFO - [mozharness: 2017-04-10 16:28:12.140574Z] Finished clobber step (success) 09:28:12 INFO - [mozharness: 2017-04-10 16:28:12.140737Z] Running read-buildbot-config step. 09:28:12 INFO - Running pre-action listener: _resource_record_pre_action 09:28:12 INFO - Running main action method: read_buildbot_config 09:28:12 INFO - Using buildbot properties: 09:28:12 INFO - { 09:28:12 INFO - "project": "", 09:28:12 INFO - "product": "firefox", 09:28:12 INFO - "who": "ffxbld@noreply.mozilla.org", 09:28:12 INFO - "installer_path": "public/build/target.tar.bz2", 09:28:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:28:12 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:28:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 09:28:12 INFO - "stage_platform": "linux64", 09:28:12 INFO - "basedir": "/builds/slave/test", 09:28:12 INFO - "buildnumber": 121, 09:28:12 INFO - "platform": "ubuntu64_hw", 09:28:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:28:12 INFO - "slavebuilddir": "test", 09:28:12 INFO - "taskId": "Q9-Rz-O5TJO6YJqt1tDBcw", 09:28:12 INFO - "branch": "mozilla-aurora", 09:28:12 INFO - "script_repo_revision": "production", 09:28:12 INFO - "revision": "718da6d0b0bc7e97a93061e19b71ec157e7b51a9", 09:28:12 INFO - "slavename": "talos-linux64-ix-012", 09:28:12 INFO - "repo_path": "releases/mozilla-aurora" 09:28:12 INFO - } 09:28:12 INFO - Finding installer, test and symbols from parent task. 09:28:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9-Rz-O5TJO6YJqt1tDBcw'}, attempt #1 09:28:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9-Rz-O5TJO6YJqt1tDBcw'}, attempt #1 09:28:13 INFO - Task dependencies: CW4O1OIPSIiA1vtrFWHmxw 09:28:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw'}, attempt #1 09:28:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 09:28:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/test_packages.json 09:28:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.crashreporter-symbols.zip 09:28:13 INFO - Running post-action listener: _resource_record_post_action 09:28:13 INFO - [mozharness: 2017-04-10 16:28:13.532185Z] Finished read-buildbot-config step (success) 09:28:13 INFO - [mozharness: 2017-04-10 16:28:13.532408Z] Running download-and-extract step. 09:28:13 INFO - Running pre-action listener: _resource_record_pre_action 09:28:13 INFO - Running main action method: download_and_extract 09:28:13 INFO - mkdir: /builds/slave/test/build/tests 09:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:13 INFO - trying https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.test_packages.json 09:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:28:14 INFO - Downloaded 896 bytes. 09:28:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:28:14 INFO - Using the following test package requirements: 09:28:14 INFO - {u'common': [u'target.common.tests.zip'], 09:28:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:28:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:28:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:28:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:28:14 INFO - u'mozbase': [u'target.common.tests.zip'], 09:28:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:28:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:28:14 INFO - u'web-platform': [u'target.common.tests.zip', 09:28:14 INFO - u'target.web-platform.tests.zip'], 09:28:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:28:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip 09:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip into memory 09:28:15 INFO - Expected file size: 59540901 09:28:15 INFO - Obtained file size: 59540901 09:28:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:28:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip 09:28:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:25 INFO - Fetch https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.common.tests.zip into memory 09:28:26 INFO - Expected file size: 59540901 09:28:26 INFO - Obtained file size: 59540901 09:28:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.talos.tests.zip 09:28:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:28:37 INFO - Fetch https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.talos.tests.zip into memory 09:28:37 INFO - Expected file size: 14404424 09:28:37 INFO - Obtained file size: 14404424 09:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:38 INFO - trying https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 09:28:38 INFO - Downloading https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:28:39 INFO - Downloaded 66774488 bytes. 09:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 09:28:39 INFO - mkdir: /builds/slave/test/properties 09:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:28:39 INFO - Contents: 09:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 09:28:39 INFO - Running post-action listener: _resource_record_post_action 09:28:39 INFO - Running post-action listener: set_extra_try_arguments 09:28:39 INFO - [mozharness: 2017-04-10 16:28:39.340320Z] Finished download-and-extract step (success) 09:28:39 INFO - [mozharness: 2017-04-10 16:28:39.340462Z] Running populate-webroot step. 09:28:39 INFO - Running pre-action listener: _resource_record_pre_action 09:28:39 INFO - Running main action method: populate_webroot 09:28:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:28:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:28:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:28:39 INFO - '--tppagecycles', 09:28:39 INFO - '7'], 09:28:39 INFO - 'tests': ['tsvgm']}}, 09:28:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:28:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:28:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:28:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:28:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:28:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['damp', 'tps']}, 09:28:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'tests': ['damp', 'tps']}, 09:28:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['dromaeo_dom']}, 09:28:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:28:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['basic_compositor_video']}, 09:28:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:28:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'other-e10s': {'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['a11yr', 09:28:39 INFO - 'ts_paint', 09:28:39 INFO - 'tpaint', 09:28:39 INFO - 'sessionrestore', 09:28:39 INFO - 'sessionrestore_no_auto_restore', 09:28:39 INFO - 'tabpaint']}, 09:28:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['tsvgx', 09:28:39 INFO - 'tsvgr_opacity', 09:28:39 INFO - 'tart', 09:28:39 INFO - 'tscrollx', 09:28:39 INFO - 'cart', 09:28:39 INFO - 'tsvg_static']}, 09:28:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:28:39 INFO - 'tsvgr_opacity', 09:28:39 INFO - 'tart', 09:28:39 INFO - 'tscrollx', 09:28:39 INFO - 'cart', 09:28:39 INFO - 'tsvg_static']}, 09:28:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'talos_options': ['--disable-e10s'], 09:28:39 INFO - 'tests': ['tp5o']}, 09:28:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:28:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'talos_options': ['--disable-e10s', 09:28:39 INFO - '--xperf_path', 09:28:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:39 INFO - 'tests': ['tp5n']}, 09:28:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:28:39 INFO - 'talos_options': ['--xperf_path', 09:28:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:28:39 INFO - 'tests': ['tp5n']}}, 09:28:39 INFO - 'talos.zip': {'path': '', 09:28:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:28:39 INFO - Running post-action listener: _resource_record_post_action 09:28:39 INFO - [mozharness: 2017-04-10 16:28:39.360420Z] Finished populate-webroot step (success) 09:28:39 INFO - [mozharness: 2017-04-10 16:28:39.360586Z] Running create-virtualenv step. 09:28:39 INFO - Running pre-action listener: _resource_record_pre_action 09:28:39 INFO - Running main action method: create_virtualenv 09:28:39 INFO - Creating virtualenv /builds/slave/test/build/venv 09:28:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:28:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:28:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:28:40 INFO - Using real prefix '/usr' 09:28:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:28:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:28:42 INFO - Installing pip.................done. 09:28:42 INFO - Return code: 0 09:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:28:43 INFO - Reading from file tmpfile_stdout 09:28:43 INFO - Output received: 09:28:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:28:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:28:43 INFO - Using env: {'DISPLAY': ':0', 09:28:43 INFO - 'HOME': '/home/cltbld', 09:28:43 INFO - 'LANG': 'en_US.UTF-8', 09:28:43 INFO - 'LANGUAGE': 'en_US:en', 09:28:43 INFO - 'LOGNAME': 'cltbld', 09:28:43 INFO - 'MAIL': '/var/mail/cltbld', 09:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:43 INFO - 'MOZ_NO_REMOTE': '1', 09:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:43 INFO - 'NO_EM_RESTART': '1', 09:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:43 INFO - 'PWD': '/builds/slave/test', 09:28:43 INFO - 'SHELL': '/bin/bash', 09:28:43 INFO - 'SHLVL': '1', 09:28:43 INFO - 'TERM': 'linux', 09:28:43 INFO - 'TMOUT': '86400', 09:28:43 INFO - 'USER': 'cltbld', 09:28:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:43 INFO - '_': '/tools/buildbot/bin/python'} 09:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:28:43 INFO - Cleaning up... 09:28:43 INFO - Return code: 0 09:28:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:43 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:28:43 INFO - Using env: {'DISPLAY': ':0', 09:28:43 INFO - 'HOME': '/home/cltbld', 09:28:43 INFO - 'LANG': 'en_US.UTF-8', 09:28:43 INFO - 'LANGUAGE': 'en_US:en', 09:28:43 INFO - 'LOGNAME': 'cltbld', 09:28:43 INFO - 'MAIL': '/var/mail/cltbld', 09:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:43 INFO - 'MOZ_NO_REMOTE': '1', 09:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:43 INFO - 'NO_EM_RESTART': '1', 09:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:43 INFO - 'PWD': '/builds/slave/test', 09:28:43 INFO - 'SHELL': '/bin/bash', 09:28:43 INFO - 'SHLVL': '1', 09:28:43 INFO - 'TERM': 'linux', 09:28:43 INFO - 'TMOUT': '86400', 09:28:43 INFO - 'USER': 'cltbld', 09:28:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:43 INFO - '_': '/tools/buildbot/bin/python'} 09:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:43 INFO - Downloading/unpacking psutil>=3.1.1 09:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:45 INFO - Installing collected packages: psutil 09:28:45 INFO - Running setup.py install for psutil 09:28:45 INFO - building 'psutil._psutil_linux' extension 09:28:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:28:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:28:46 INFO - building 'psutil._psutil_posix' extension 09:28:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:28:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:28:47 INFO - Successfully installed psutil 09:28:47 INFO - Cleaning up... 09:28:47 INFO - Return code: 0 09:28:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:47 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:28:47 INFO - Using env: {'DISPLAY': ':0', 09:28:47 INFO - 'HOME': '/home/cltbld', 09:28:47 INFO - 'LANG': 'en_US.UTF-8', 09:28:47 INFO - 'LANGUAGE': 'en_US:en', 09:28:47 INFO - 'LOGNAME': 'cltbld', 09:28:47 INFO - 'MAIL': '/var/mail/cltbld', 09:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:47 INFO - 'MOZ_NO_REMOTE': '1', 09:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:47 INFO - 'NO_EM_RESTART': '1', 09:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:47 INFO - 'PWD': '/builds/slave/test', 09:28:47 INFO - 'SHELL': '/bin/bash', 09:28:47 INFO - 'SHLVL': '1', 09:28:47 INFO - 'TERM': 'linux', 09:28:47 INFO - 'TMOUT': '86400', 09:28:47 INFO - 'USER': 'cltbld', 09:28:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:47 INFO - '_': '/tools/buildbot/bin/python'} 09:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:28:49 INFO - Installing collected packages: mozsystemmonitor 09:28:49 INFO - Running setup.py install for mozsystemmonitor 09:28:49 INFO - Successfully installed mozsystemmonitor 09:28:49 INFO - Cleaning up... 09:28:49 INFO - Return code: 0 09:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:49 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:28:49 INFO - Using env: {'DISPLAY': ':0', 09:28:49 INFO - 'HOME': '/home/cltbld', 09:28:49 INFO - 'LANG': 'en_US.UTF-8', 09:28:49 INFO - 'LANGUAGE': 'en_US:en', 09:28:49 INFO - 'LOGNAME': 'cltbld', 09:28:49 INFO - 'MAIL': '/var/mail/cltbld', 09:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:49 INFO - 'MOZ_NO_REMOTE': '1', 09:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:49 INFO - 'NO_EM_RESTART': '1', 09:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:49 INFO - 'PWD': '/builds/slave/test', 09:28:49 INFO - 'SHELL': '/bin/bash', 09:28:49 INFO - 'SHLVL': '1', 09:28:49 INFO - 'TERM': 'linux', 09:28:49 INFO - 'TMOUT': '86400', 09:28:49 INFO - 'USER': 'cltbld', 09:28:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:49 INFO - '_': '/tools/buildbot/bin/python'} 09:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 09:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:28:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:28:52 INFO - warning: no files found matching '*.txt' 09:28:52 INFO - no previously-included directories found matching 'build' 09:28:52 INFO - no previously-included directories found matching 'dist' 09:28:52 INFO - no previously-included directories found matching '.git*' 09:28:52 INFO - Installing collected packages: jsonschema, functools32 09:28:52 INFO - Running setup.py install for functools32 09:28:52 INFO - warning: no files found matching '*.txt' 09:28:52 INFO - no previously-included directories found matching 'build' 09:28:52 INFO - no previously-included directories found matching 'dist' 09:28:52 INFO - no previously-included directories found matching '.git*' 09:28:52 INFO - Successfully installed jsonschema functools32 09:28:52 INFO - Cleaning up... 09:28:52 INFO - Return code: 0 09:28:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:53 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:28:53 INFO - Using env: {'DISPLAY': ':0', 09:28:53 INFO - 'HOME': '/home/cltbld', 09:28:53 INFO - 'LANG': 'en_US.UTF-8', 09:28:53 INFO - 'LANGUAGE': 'en_US:en', 09:28:53 INFO - 'LOGNAME': 'cltbld', 09:28:53 INFO - 'MAIL': '/var/mail/cltbld', 09:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:53 INFO - 'MOZ_NO_REMOTE': '1', 09:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:53 INFO - 'NO_EM_RESTART': '1', 09:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:53 INFO - 'PWD': '/builds/slave/test', 09:28:53 INFO - 'SHELL': '/bin/bash', 09:28:53 INFO - 'SHLVL': '1', 09:28:53 INFO - 'TERM': 'linux', 09:28:53 INFO - 'TMOUT': '86400', 09:28:53 INFO - 'USER': 'cltbld', 09:28:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:53 INFO - '_': '/tools/buildbot/bin/python'} 09:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:28:53 INFO - Cleaning up... 09:28:53 INFO - Return code: 0 09:28:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:53 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:28:53 INFO - Using env: {'DISPLAY': ':0', 09:28:53 INFO - 'HOME': '/home/cltbld', 09:28:53 INFO - 'LANG': 'en_US.UTF-8', 09:28:53 INFO - 'LANGUAGE': 'en_US:en', 09:28:53 INFO - 'LOGNAME': 'cltbld', 09:28:53 INFO - 'MAIL': '/var/mail/cltbld', 09:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:53 INFO - 'MOZ_NO_REMOTE': '1', 09:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:53 INFO - 'NO_EM_RESTART': '1', 09:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:53 INFO - 'PWD': '/builds/slave/test', 09:28:53 INFO - 'SHELL': '/bin/bash', 09:28:53 INFO - 'SHLVL': '1', 09:28:53 INFO - 'TERM': 'linux', 09:28:53 INFO - 'TMOUT': '86400', 09:28:53 INFO - 'USER': 'cltbld', 09:28:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:53 INFO - '_': '/tools/buildbot/bin/python'} 09:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:53 INFO - Downloading/unpacking blobuploader==1.2.4 09:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:28:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:28:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:56 INFO - Downloading docopt-0.6.1.tar.gz 09:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:28:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:28:56 INFO - Running setup.py install for blobuploader 09:28:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:28:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:28:56 INFO - Running setup.py install for requests 09:28:57 INFO - Running setup.py install for docopt 09:28:57 INFO - Successfully installed blobuploader requests docopt 09:28:57 INFO - Cleaning up... 09:28:57 INFO - Return code: 0 09:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:57 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:28:57 INFO - Using env: {'DISPLAY': ':0', 09:28:57 INFO - 'HOME': '/home/cltbld', 09:28:57 INFO - 'LANG': 'en_US.UTF-8', 09:28:57 INFO - 'LANGUAGE': 'en_US:en', 09:28:57 INFO - 'LOGNAME': 'cltbld', 09:28:57 INFO - 'MAIL': '/var/mail/cltbld', 09:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:57 INFO - 'MOZ_NO_REMOTE': '1', 09:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:28:57 INFO - 'NO_EM_RESTART': '1', 09:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:57 INFO - 'PWD': '/builds/slave/test', 09:28:57 INFO - 'SHELL': '/bin/bash', 09:28:57 INFO - 'SHLVL': '1', 09:28:57 INFO - 'TERM': 'linux', 09:28:57 INFO - 'TMOUT': '86400', 09:28:57 INFO - 'USER': 'cltbld', 09:28:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:57 INFO - '_': '/tools/buildbot/bin/python'} 09:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:28:57 INFO - Running setup.py (path:/tmp/pip-J6SIBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:28:57 INFO - Running setup.py (path:/tmp/pip-11E5Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:28:57 INFO - Running setup.py (path:/tmp/pip-wWBZAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:28:57 INFO - Running setup.py (path:/tmp/pip-fMViXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:28:57 INFO - Running setup.py (path:/tmp/pip-hiZCxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:28:57 INFO - Running setup.py (path:/tmp/pip-zN0MYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:28:57 INFO - Running setup.py (path:/tmp/pip-aLvTCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:28:57 INFO - Running setup.py (path:/tmp/pip-GLP0QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:28:58 INFO - Running setup.py (path:/tmp/pip-Iw11o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:28:58 INFO - Running setup.py (path:/tmp/pip-pSLXRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:28:58 INFO - Running setup.py (path:/tmp/pip-5iqWGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:28:58 INFO - Running setup.py (path:/tmp/pip-tAGbRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:28:58 INFO - Running setup.py (path:/tmp/pip-DCHrjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:28:58 INFO - Running setup.py (path:/tmp/pip-oiUZMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:58 INFO - Running setup.py (path:/tmp/pip-SuVG_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:28:58 INFO - Running setup.py (path:/tmp/pip-3c3KRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:28:58 INFO - Running setup.py (path:/tmp/pip-y37hZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:28:58 INFO - Running setup.py install for manifestparser 09:28:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:28:58 INFO - Running setup.py install for mozcrash 09:28:58 INFO - Running setup.py install for mozdebug 09:28:58 INFO - Running setup.py install for mozdevice 09:28:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for mozfile 09:28:59 INFO - Running setup.py install for mozhttpd 09:28:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for mozinfo 09:28:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for mozInstall 09:28:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for mozleak 09:28:59 INFO - Running setup.py install for mozlog 09:28:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for moznetwork 09:28:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:28:59 INFO - Running setup.py install for mozprocess 09:28:59 INFO - Running setup.py install for mozprofile 09:29:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:00 INFO - Running setup.py install for mozrunner 09:29:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:00 INFO - Running setup.py install for mozscreenshot 09:29:00 INFO - Running setup.py install for moztest 09:29:00 INFO - Running setup.py install for mozversion 09:29:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:00 INFO - Cleaning up... 09:29:00 INFO - Return code: 0 09:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:00 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:00 INFO - Using env: {'DISPLAY': ':0', 09:29:00 INFO - 'HOME': '/home/cltbld', 09:29:00 INFO - 'LANG': 'en_US.UTF-8', 09:29:00 INFO - 'LANGUAGE': 'en_US:en', 09:29:00 INFO - 'LOGNAME': 'cltbld', 09:29:00 INFO - 'MAIL': '/var/mail/cltbld', 09:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:00 INFO - 'MOZ_NO_REMOTE': '1', 09:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:00 INFO - 'NO_EM_RESTART': '1', 09:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:00 INFO - 'PWD': '/builds/slave/test', 09:29:00 INFO - 'SHELL': '/bin/bash', 09:29:00 INFO - 'SHLVL': '1', 09:29:00 INFO - 'TERM': 'linux', 09:29:00 INFO - 'TMOUT': '86400', 09:29:00 INFO - 'USER': 'cltbld', 09:29:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:00 INFO - '_': '/tools/buildbot/bin/python'} 09:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:00 INFO - Running setup.py (path:/tmp/pip-kIg0r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:00 INFO - Running setup.py (path:/tmp/pip-1aHOyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:00 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)) 09:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:00 INFO - Running setup.py (path:/tmp/pip-SuWPNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:00 INFO - Running setup.py (path:/tmp/pip-ehphde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:01 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)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:01 INFO - Running setup.py (path:/tmp/pip-CkaeDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:01 INFO - Running setup.py (path:/tmp/pip-NSvFiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:01 INFO - Running setup.py (path:/tmp/pip-wJRGqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:01 INFO - Running setup.py (path:/tmp/pip-6nSL0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:01 INFO - Running setup.py (path:/tmp/pip-JYnaFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:01 INFO - Running setup.py (path:/tmp/pip-pXsO5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:01 INFO - Running setup.py (path:/tmp/pip-84KndB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:01 INFO - Running setup.py (path:/tmp/pip-YykoHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:01 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)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:01 INFO - Running setup.py (path:/tmp/pip-Kvt4vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:01 INFO - Running setup.py (path:/tmp/pip-v4_1K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:01 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)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:01 INFO - Running setup.py (path:/tmp/pip-trSNSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:01 INFO - Running setup.py (path:/tmp/pip-g3MxXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:01 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)) 09:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:01 INFO - Running setup.py (path:/tmp/pip-lMjXLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:29:01 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)) 09:29:01 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)) 09:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:01 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)) 09:29:01 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)) 09:29:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:03 INFO - Downloading blessings-1.6.tar.gz 09:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:04 INFO - Installing collected packages: blessings 09:29:04 INFO - Running setup.py install for blessings 09:29:04 INFO - Successfully installed blessings 09:29:04 INFO - Cleaning up... 09:29:04 INFO - Return code: 0 09:29:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:04 INFO - Reading from file tmpfile_stdout 09:29:04 INFO - Current package versions: 09:29:04 INFO - argparse == 1.2.1 09:29:04 INFO - blessings == 1.6 09:29:04 INFO - blobuploader == 1.2.4 09:29:04 INFO - docopt == 0.6.1 09:29:04 INFO - functools32 == 3.2.3-2 09:29:04 INFO - jsonschema == 2.5.1 09:29:04 INFO - manifestparser == 1.1 09:29:04 INFO - mozInstall == 1.12 09:29:04 INFO - mozcrash == 1.0 09:29:04 INFO - mozdebug == 0.1 09:29:04 INFO - mozdevice == 0.49 09:29:04 INFO - mozfile == 1.2 09:29:04 INFO - mozhttpd == 0.7 09:29:04 INFO - mozinfo == 0.9 09:29:04 INFO - mozleak == 0.1 09:29:04 INFO - mozlog == 3.4 09:29:04 INFO - moznetwork == 0.27 09:29:04 INFO - mozprocess == 0.25 09:29:04 INFO - mozprofile == 0.28 09:29:04 INFO - mozrunner == 6.13 09:29:04 INFO - mozscreenshot == 0.1 09:29:04 INFO - mozsystemmonitor == 0.3 09:29:04 INFO - moztest == 0.8 09:29:04 INFO - mozversion == 1.4 09:29:04 INFO - psutil == 3.1.1 09:29:04 INFO - requests == 1.2.3 09:29:04 INFO - wsgiref == 0.1.2 09:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:04 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:04 INFO - Using env: {'DISPLAY': ':0', 09:29:04 INFO - 'HOME': '/home/cltbld', 09:29:04 INFO - 'LANG': 'en_US.UTF-8', 09:29:04 INFO - 'LANGUAGE': 'en_US:en', 09:29:04 INFO - 'LOGNAME': 'cltbld', 09:29:04 INFO - 'MAIL': '/var/mail/cltbld', 09:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:04 INFO - 'MOZ_NO_REMOTE': '1', 09:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:04 INFO - 'NO_EM_RESTART': '1', 09:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:04 INFO - 'PWD': '/builds/slave/test', 09:29:04 INFO - 'SHELL': '/bin/bash', 09:29:04 INFO - 'SHLVL': '1', 09:29:04 INFO - 'TERM': 'linux', 09:29:04 INFO - 'TMOUT': '86400', 09:29:04 INFO - 'USER': 'cltbld', 09:29:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:04 INFO - '_': '/tools/buildbot/bin/python'} 09:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:04 INFO - Cleaning up... 09:29:04 INFO - Return code: 0 09:29:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:04 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 0x18371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1930a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:29:04 INFO - Using env: {'DISPLAY': ':0', 09:29:04 INFO - 'HOME': '/home/cltbld', 09:29:04 INFO - 'LANG': 'en_US.UTF-8', 09:29:04 INFO - 'LANGUAGE': 'en_US:en', 09:29:04 INFO - 'LOGNAME': 'cltbld', 09:29:04 INFO - 'MAIL': '/var/mail/cltbld', 09:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:04 INFO - 'MOZ_NO_REMOTE': '1', 09:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:04 INFO - 'NO_EM_RESTART': '1', 09:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:04 INFO - 'PWD': '/builds/slave/test', 09:29:04 INFO - 'SHELL': '/bin/bash', 09:29:04 INFO - 'SHLVL': '1', 09:29:04 INFO - 'TERM': 'linux', 09:29:04 INFO - 'TMOUT': '86400', 09:29:04 INFO - 'USER': 'cltbld', 09:29:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:04 INFO - '_': '/tools/buildbot/bin/python'} 09:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:04 INFO - Cleaning up... 09:29:04 INFO - Return code: 0 09:29:04 INFO - Running post-action listener: _resource_record_post_action 09:29:04 INFO - Running post-action listener: _start_resource_monitoring 09:29:04 INFO - Starting resource monitoring. 09:29:04 INFO - [mozharness: 2017-04-10 16:29:04.961180Z] Finished create-virtualenv step (success) 09:29:04 INFO - [mozharness: 2017-04-10 16:29:04.961649Z] Running install step. 09:29:04 INFO - Running pre-action listener: _resource_record_pre_action 09:29:04 INFO - Running main action method: install 09:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:05 INFO - Reading from file tmpfile_stdout 09:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:05 INFO - Reading from file tmpfile_stdout 09:29:05 INFO - Output received: 09:29:05 INFO - Usage: mozinstall [options] installer 09:29:05 INFO - Options: 09:29:05 INFO - -h, --help show this help message and exit 09:29:05 INFO - -d DEST, --destination=DEST 09:29:05 INFO - Directory to install application into. [default: 09:29:05 INFO - "/builds/slave/test"] 09:29:05 INFO - --app=APP Application being installed. [default: firefox] 09:29:05 INFO - mkdir: /builds/slave/test/build/application 09:29:05 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'] 09:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:29:21 INFO - Reading from file tmpfile_stdout 09:29:21 INFO - Output received: 09:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:21 INFO - Running post-action listener: _resource_record_post_action 09:29:21 INFO - [mozharness: 2017-04-10 16:29:21.843239Z] Finished install step (success) 09:29:21 INFO - [mozharness: 2017-04-10 16:29:21.843516Z] Running run-tests step. 09:29:21 INFO - Running pre-action listener: _resource_record_pre_action 09:29:21 INFO - Running main action method: run_tests 09:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:21 INFO - Python 2.7.3 09:29:21 INFO - Return code: 0 09:29:21 INFO - grabbing minidump binary from tooltool 09:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:21 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 0x1ad2290>, '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 0x1ad2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad3040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:29:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:29:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:21 INFO - Return code: 0 09:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:21 INFO - ENV: RUST_BACKTRACE is now 1 09:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:29:21 INFO - Using env: {'DISPLAY': ':0', 09:29:21 INFO - 'HOME': '/home/cltbld', 09:29:21 INFO - 'LANG': 'en_US.UTF-8', 09:29:21 INFO - 'LANGUAGE': 'en_US:en', 09:29:21 INFO - 'LOGNAME': 'cltbld', 09:29:21 INFO - 'MAIL': '/var/mail/cltbld', 09:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:21 INFO - 'MOZ_NO_REMOTE': '1', 09:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:21 INFO - 'NO_EM_RESTART': '1', 09:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:21 INFO - 'PWD': '/builds/slave/test', 09:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:21 INFO - 'RUST_BACKTRACE': '1', 09:29:21 INFO - 'SHELL': '/bin/bash', 09:29:21 INFO - 'SHLVL': '1', 09:29:21 INFO - 'TERM': 'linux', 09:29:21 INFO - 'TMOUT': '86400', 09:29:21 INFO - 'USER': 'cltbld', 09:29:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544', 09:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:21 INFO - '_': '/tools/buildbot/bin/python'} 09:29:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:29:22 INFO - mozversion application_buildid: 20170410153543 09:29:22 INFO - mozversion application_changeset: 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 09:29:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:29:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:22 INFO - mozversion application_name: Firefox 09:29:22 INFO - mozversion application_remotingname: firefox-dev 09:29:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:29:22 INFO - mozversion application_vendor: Mozilla 09:29:22 INFO - mozversion application_version: 54.0a2 09:29:22 INFO - mozversion platform_buildid: 20170410153543 09:29:22 INFO - mozversion platform_changeset: 718da6d0b0bc7e97a93061e19b71ec157e7b51a9 09:29:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:29:22 INFO - mozversion platform_version: 54.0a2 09:29:22 INFO - using testdate: 1491841762 09:29:22 INFO - actual date: 1491841762 09:29:22 INFO - starting webserver on 'localhost:43073' 09:29:22 INFO - SUITE-START | Running 2 tests 09:29:22 INFO - TEST-START | dromaeo_css 09:29:22 INFO - operating with platform_type : linux_ 09:29:22 INFO - Initialising browser for dromaeo_css test... 09:29:22 INFO - TEST-INFO | started process 3300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjOUtk/profile http://localhost:43073/getInfo.html) 09:29:27 INFO - PROCESS | 3300 | __metrics Screen width/height:1600/1200 09:29:27 INFO - PROCESS | 3300 | colorDepth:24 09:29:27 INFO - PROCESS | 3300 | Browser inner width/height: 1024/697 09:29:27 INFO - PROCESS | 3300 | __metrics 09:29:28 ERROR - PROCESS | 3300 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 09:29:28 INFO - TEST-INFO | 3300: exit 0 09:29:28 INFO - Browser initialized. 09:29:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:29:28 INFO - TEST-INFO | started process 3429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjOUtk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:40 INFO - PROCESS | 3429 | RSS: Main: 146845696 09:29:40 INFO - PROCESS | 3429 | 09:32:41 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43073/tests/dromaeo/cssquery-ext.html) 09:32:43 INFO - PROCESS | 3429 | RSS: Main: 155291648 09:32:43 INFO - PROCESS | 3429 | 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | A coding exception was thrown and uncaught in a Task. 09:34:29 INFO - PROCESS | 3429 | 09:34:29 ERROR - PROCESS | 3429 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:29 INFO - PROCESS | 3429 | Full stack: 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | A coding exception was thrown and uncaught in a Task. 09:34:29 INFO - PROCESS | 3429 | 09:34:29 ERROR - PROCESS | 3429 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:29 INFO - PROCESS | 3429 | Full stack: 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | A coding exception was thrown and uncaught in a Task. 09:34:29 INFO - PROCESS | 3429 | 09:34:29 ERROR - PROCESS | 3429 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:29 INFO - PROCESS | 3429 | Full stack: 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | ************************* 09:34:29 INFO - PROCESS | 3429 | A coding exception was thrown and uncaught in a Task. 09:34:29 INFO - PROCESS | 3429 | 09:34:29 ERROR - PROCESS | 3429 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:34:29 INFO - PROCESS | 3429 | Full stack: 09:34:29 INFO - PROCESS | 3429 | ************************* 09:35:45 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-ext.html (next: http://localhost:43073/tests/dromaeo/cssquery-jquery.html) 09:35:46 INFO - PROCESS | 3429 | RSS: Main: 152506368 09:35:46 INFO - PROCESS | 3429 | 09:38:47 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43073/tests/dromaeo/cssquery-mootools.html) 09:38:48 INFO - PROCESS | 3429 | RSS: Main: 154218496 09:38:48 INFO - PROCESS | 3429 | 09:41:50 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43073/tests/dromaeo/cssquery-prototype.html) 09:41:50 INFO - PROCESS | 3429 | RSS: Main: 153694208 09:41:50 INFO - PROCESS | 3429 | 09:44:53 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43073/tests/dromaeo/cssquery-yui.html) 09:44:54 INFO - PROCESS | 3429 | RSS: Main: 157286400 09:44:54 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | Cycle 1(1): loaded http://localhost:43073/tests/dromaeo/cssquery-yui.html (next: http://localhost:43073/tests/dromaeo/cssquery-dojo.html) 09:47:56 INFO - PROCESS | 3429 | RSS: Main: 156966912 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | __start_tp_report 09:47:56 INFO - PROCESS | 3429 | _x_x_mozilla_page_load 09:47:56 INFO - PROCESS | 3429 | _x_x_mozilla_page_load_details 09:47:56 INFO - PROCESS | 3429 | |i|pagename|runs| 09:47:56 INFO - PROCESS | 3429 | |0;dojo.html;3393.236521782599;3451.896443106706;3460.4982277569743;3468.3583537045647;3485.546878905742;5875.236219291492;5907.881842363156;5930.229070220876;5945.346011938684;5962.940370596293;5851.561132915038;5927.2590926134235;5937.643741375509;5961.791337303195;5964.194833697449;5343.332083489564;5404.756785944642;5427.864303392407;5440.782368705247;5453.2092846537225;5364.007658583155;5457.045017122007;5463.289772329612;5480.561555075605;5485.862853428656;5274.525292723654;5282.5245727884485;5459.481349271813;5474.19110916545;5506.504414602685;5326.094563924162;5331.680099194042;5355.437679043684;5362.865928351784;5397.7571009304675;5318.601104917108;5393.379761327458;5394.973025134888;5410.783568657249;5419.241306217133;5689.7439615217;5873.2658417697785;5904.5276377890095;5951.345352011275;5964.015937370329;6142.161149281699;6205.937940620581;6211.937880621181;6220.968895155495;6273.1531243282025;6399.26408463028;6414.198225221848;6416.294207637156;6423.068655044993;6423.229212494531;5928.3775203603;5947.91078133824;5955;5964.373740757244;5974.880502389928;6099;6167.198264225712;6296;6308.873822523524;6361.236651601837;6132.447291485777;6206.224221972254;6215.751369945152;6223.688815559204;6274.686265686697;6315.431611155018;6320.209973753281;6353.269374021954;6361.968190159019;6363.9045414318825;6026.427489388501;6078.057901025348;6173.444390004921;6178.104174894615;6200.968995154995;6280.780172694025;6289.0880822280515;6304.054391841169;6306.085617585424;6328.272248691367;4668.299755036772;4697.248440249544;4714.811407543729;4749.596284315803;4766.880827979328;4209.684273679486;4241.236577416094;4243.257429949808;4266.445362102907;4276.123394704078;6104.3590423005835;6144.662043587646;6181.412765787243;6204.565680402418;6207.6275423474735;6343.111964324999;6386.425221729974;6391.872162556816;6416.101745755598;6419.454346380517;5966.433188847052;6191.318954914956;6199;6202.81391558254;6209.2548894133;5322.8935421292135;5327.0411325961695;5334.3865455473115;5341.172118321666;5367.731613419313;6553.4101930826455;6568.1789776277965;6569.57297775643;6579.440747536513;6609.669516524058;6408.551401401857;6426.678666066771;6426.903596446151;6429.678516074271;6441.581297215666;6299.842503937255;6331.9050214247745;6363.745450181941;6406.455451286693;6420.069089981833;6157.722902469489;6182.629042257479;6187.3503282154725;6209.348018457997;6213.844653883508;6307.148534947723;6309.242890852944;6314.842128946813;6325.746970121144;6348.079528468438;6027.638341699512;6050.334463208956;6093.055576385667;6116.122740413025;6118.571699980958;6198.969005154945;6210.534209934363;6213.565050446426;6216.7824126155365;6223.875522489434;6098.908516372347;6170.981788004929;6191.226096737908;6195.2255968004;6198.1012753149635;6000.669963152069;6020.638761674313;6123.1606109212;6151.661658608819;6167.660778657038;6065.423784740443;6096.1465394845645;6103.511719062376;6105.725242364016;6131.325554188947 09:47:56 INFO - PROCESS | 3429 | |1;ext.html;764.8126209078777;836.9330453563714;853.5476197615264;908.2234689340613;921.2998121427721;42632.786836065774;42666.360004599956;43074.353884691714;43193.352099718526;47113.76443117788;44079.559204407946;44203.11593768123;44335.334969975476;44548.33177502332;44586.554134458645;9091.27269818413;10126.139278161365;10393.896061039368;10642.78714425711;10713.839292410581;10302.896971030306;10317.793644127112;10336.328138671;10364.326318789255;10394.428306443142;10433.373997560133;10449.477526123701;10490.950904909525;10499.475026248696;10525.157987360994;10383.636572719955;10416.791664166713;10421.79156416875;10456.738581535446;10463.843042354332;10224.539895704711;10226.181905447545;10278.126359259471;10295.433751143684;10301.330413523097;35864.56541738327;35939.28121437583;35971.82014089913;36030.81984590086;36153.09617259563;4121.5466298707115;4125.834966601333;4170.749755014709;4184.037671335579;4228.365745138223;27423;27480.312992175157;27581.31046723828;27589.58615620767;28723.27660340386;4294.9785251073545;4391.538888416734;4415.558444155591;4429.844955426544;4461.598456138963;228451;231235;236310;245458;246182;46712.53287467082;47325.29012064822;47485.050298993825;47499.28751068737;47604.76197619059;49336.75331623319;49449;49673;49680.50319496831;49719.751401243484;14393.136411815325;14457.92771036138;14490.710185796224;14506.927465362605;14510.492132775513;12319.137660363867;12347.38263086842;12363.258204507758;12368.257904525757;12437.689057773629;13131.146475479254;13181.868181318256;13189.472421103048;13370.06409551322;13431.12697674648;5465.4261302563455;5508.228847961289;5575.553955683536;5584.301962254718;5623.493885550321;981.8281800684852;995.7311525887969;1009.7122320138725;1011.3072545306488;1012.8733908261468;28199.57700634492;28200.85899570489;28450.288742781595;28802.855985719936;28824.42351152965;1074.6346242277664;1081.7836432713332;1103.3545375955157;1105.082781291526;1113.9974023379025;14813.407463701547;15008.549743507712;15961.36154553828;16822.831771682126;17104.572385690208;329929;331088;331721;332104;332448;52671.47328526742;53012.469875300754;53012.73493632507;53067.46932530625;53164.46835531673;1464.5899148238511;1468.5594321703447;1487.248939285654;1489.6573788028813;1502.2113390469872;28472.430551389272;28906;28926.421471570873;29531.557026644186;29599.85200073986;38982.6101738979;39030.21939561136;39095.80452097721;39374.409383859835;39425.60574394219;336530;336608;337881;337988;338863;30268.84865575658;30757.23106922345;31354.843225783727;32700.50949235811;33436.83281583576;39533.40699889446;39865.40201897032;40031.59968400279;40065.1986960265;40441.39337909875;31706.841465792524;31946.20134496656;32105.67894321027;32157.678423216403;32565.88321759078;31258;31340.216494587818;31622.841885790425;31718.682813171574;31883.521747174276;35205.64794352126;35605.28789424249;35678.286434271686;35678.821605892845;35824.82087589546;30482.695173048873;30611.23471913131;31626.36747265088;33915.32169356648;33930.8303458491;24410.755892440848;25766;26009.479810404064;26317.21048368552;26600.201993940213 09:47:56 INFO - PROCESS | 3429 | |2;jquery.html;435.4948260018379;450.8827704796752;457.06758213244984;465.31598550131315;472.83450792222726;18378.264869405226;19779.604407911833;20496.077676504556;21880.343589692315;22077.779222207773;21500.46248843776;21606.243781467652;21976.45058873529;22011.889940550314;22548.774512254873;6677.766278180253;6752.324767523258;6973.581585104885;6980.127484064492;6997.965010174942;6842.897356539655;6922.753904297225;6964.373206411422;6970.09388779458;6984;6710.16122984627;6853;6910.4471642268745;6952.374286314256;6999;6694.765683201064;6904.654767261642;6919.204291506466;6992.965035174842;7018.89471657923;6625.3043430440075;6653.201615806134;6691.631960242234;6692.531522793406;6696.430803381719;25481.235562933143;25701.742982570122;25917;26171.084012059488;26296.474070518674;3255.983720081408;3329.1137978809156;3352.4133276676484;3653.488511608377;3707.1658876752786;17659.646807063786;18629.7205541917;18933.81066189334;18936.147873345733;19211;2282.2924893283134;2347.917822876208;2357.5167090746527;2387.594109001474;2408.747081556429;84109.15890841074;87366;116042.41978790052;118176;124220.49888071552;21945.912031112373;22047.559048818934;22459.32622021342;22674.886625566767;22882.31353059411;42134.57865421368;42749.78625106917;42829.571704282556;43126.784366078595;43138.568614314085;9716.465594392235;10081.798364032678;10315.896841031643;10356.378617282988;10612.787744245072;8559.74320770378;8697.851323273462;8758.605862736193;8903.688370907117;8905.421147625384;9035.412698174598;9349.719508414759;9569.952150239204;9637.951810240904;9692.903070969342;3461.962844061884;3696.7302765306113;3789.2610940866266;4018.7588744675413;4086.1827634473225;1154.630518234174;1166.9591564295208;1182.4501606752729;1183.8875306845837;1205.427421974555;19359.4192174235;20481.38555843327;20528.692069618966;20620.69068963967;20689.58620827575;1164.7554013657057;1164.889335513125;1166.854143232096;1184.5972369394276;1191.8212268159846;10654.840177397346;11280.717982050515;11395.316281023164;11502.367369794742;11521.423928803526;741783;748405;752875;754961;759655;106316;110242.44878775715;110383.44808275907;110399;111381;1207.8610959739742;1242.3105176626877;1275.2093701904878;1278.015927735657;1282.6472720002075;17682;17883.28466861311;18058.81941180624;18274.817251827313;18416.90791546034;40610.59389406068;50706.74646626891;50756.23865642092;51351.48648513467;53035.73482132565;63808.68095659492;64452.35547644651;65134.348656514725;65554;72696.63651681707;9759;10925.90740925901;12688.809667855174;12913.612591622266;13025;14400.063995840237;14554.12675239489;14738.63153421173;14907.105573665614;15135.243237837843;12334.938325308316;12377;12571.371431428575;12595.748085038065;12670.429830657828;11275.379854108103;11281;11314.60398886035;11369.658910232707;11545.942270288595;12991.28547929873;13040.739185216433;13044.739105218032;13134.277614731282;13138.408771605491;13158.342082895626;13207.405666744828;13219.867801321863;13248.933755331162;13266.53567125146;12017.63947081589;12820.423080961566;12870;12925;12994.220346779224 09:47:56 INFO - PROCESS | 3429 | |3;mootools.html;1550.8836837237207;1559.8440155984397;1576.6216108134038;1588.372592825834;1610.7825443565116;10907.181961352891;11627.651170464878;11647.35939523326;11771.70570735732;12132.393380330992;11793.115516336266;11867.287962722243;11935.462904169312;11945.104117191224;11958.521659133647;2390.8445951013173;2402.0992127952018;2411.6744239527616;2419.9516009679883;2419.9879000604974;2342;2376.085207195225;2459.5080983803223;2468.111479867255;2470.1848390031246;2321.3384185507134;2331.137479132715;2332.650102484624;2461.3477428481465;2468.2348471973746;2236.630955892276;2294.8967296471615;2294.9311520654405;2299.862008279492;2356.422676444282;2220;2240.5182885679496;2242.5963326601204;2243.4391402149463;2245.2029529517113;11559.76880462386;11580.131490138188;11611.94194029033;11693.473793679304;11717.414129293586;5511.58663100269;5794.217780599607;5822.767089316422;5826.912596311059;5839.970800146015;3469.9479507807405;3490.703290220334;3517.8944631661093;3600.4959305697225;3619.1856832212807;1369.3906211735782;1369.4179973511218;1414.5897689669982;1428.300132934865;1467.347030571396;15135.318910649048;15372.30824612895;16122.274497647633;17096.487105386735;17334.133293335282;4584.358189853423;4612.262038073892;4754.191787396151;4768.57082862544;4774.7135171889795;13530.932345338408;13589.660258493617;13591.320433978262;13595.796063059062;13645.590632281048;5943.791967281124;5975.282966044103;5979.880402392015;5983.19226904371;5984.461398474158;5408.7566059526625;5446.564274858002;5469.15228139639;5521.420250873601;5549.306336707911;4002.8598999034893;4074.2055299216963;4113.239050775556;4117.2588933992165;4137.13120244752;1046.0899017854515;1051.2851261142343;1071.5927947379946;1075.0754351257913;1082.3019152646498;1041.13065590233;1057.2387880725864;1057.381431862369;1066.344198318029;1075.8977897099762;7381.077365329334;7381.1511676157925;7397.297256760599;7401.518901271508;7589.316961473494;1052.6578861869923;1056.1181413519796;1056.957721691139;1062.3997441445558;1064.0724322930619;4398.186335527937;4550.613197878218;4584.106099310602;4683.227267500824;4712.24604063355;14020.228887411291;14530.782038269223;14535.78196327056;14554.927225363805;14596.270186490632;13904.304784760721;14239.43042278318;14307.856921430652;14404.423823047171;14405.639859003399;8284.420090593721;10844.783104337868;11008.669739907815;11056.613018544473;11071.225014248925;6316.652584107918;7011.789646310619;7031.624820086285;7363.963180184065;7596.278353556403;13424.127431717297;13629.114107582975;13717.725645487233;13731.038827281995;13979.720405591628;13300.800487992881;13574.660633484242;13611.79582306286;13774.517891873737;13777.173369597856;9805.803883922139;9808.9019109808;9892.109710126124;10007.899921000697;10032.69901902944;10811.135109191404;10901.672949811518;10937.781244375226;10949.890501094887;10955;8722.215000649972;8722.825543489222;8755.255803256794;8790.120987901159;8894.777630559287;9012.369134160546;9055.36612437123;9071.637134514545;9274.118958698913;9294.860577091484;7691.884621730566;7713.421493387906;7767.378609711097;7796.610169491616;7811.765647030598;6281.937180628135;6283.528735344776;6295.464885484602;6324.4940404766585;6327.082573026793;6555.770548030796;6581.177352830896;6654.567453115726;6709.914746600971;6795.694193761392 09:47:56 INFO - PROCESS | 3429 | |4;prototype.html;409.8667932921801;419.3311667889715;435.3817579037768;438.3731264292062;443.72267332916914;5201.375834899808;5280.815171468999;5352.384475785286;5361.437049109846;5385.246065550821;5223.320968274129;5268.262443257938;5277.656952298098;5286.392064912537;5334.946045772386;4573.7713114344315;4611.446626404836;4615.769211539427;4625.930611040837;4651.767411629422;4498.460184777831;4562.749048802315;4595.333676616889;4605.700629459075;4632.235681112612;4556.587457888048;4584.908301833962;4595.333676616889;4595.517470665583;4611;4578.908421831561;4584.610308123813;4596.954030459686;4610.907781844345;4612.1090352955125;4025.275450418953;4164.208800327959;4428.335749637548;4445.955540444619;4447.51077381491;5151.484851514856;5151.896962060775;5151.922721159186;5155.767990440401;5194.71429071401;5153.845384638467;5154.278401023859;5188.688678679291;5220.504052115043;5230.686158830445;5406.405295417501;5613.46672066153;5614.438556144353;5641.464060914206;5654.236678048452;4702.365180700596;4702.612729244881;4708.552687494683;4709.364235828154;4709.811607535695;5845.386234445365;5847.502962248172;5848.853778655568;5873.412658734135;5876.382979787147;4633.907321853544;4792.904141917142;4793.784279707352;4796.426662136731;4818.458093410075;4872.43966943806;4885.511448855086;4894.681845680019;4895.363602731622;4925.458199598042;5202.283246528712;5209.973950130301;5218.347706536683;5230.215467679803;5304.594282515137;5461.672299661954;5592.720363981784;5606.617187695213;5636.774529018793;5758.481736643722;1645.2514106081944;1646.6788976149535;1665.2173478465345;1675.589480577242;1687.5949772054619;1262.3372729317182;1310.4561606933016;1318.815365848782;1322.7486777512242;1345.468539926743;5572;5598.5086636446395;5602.12328869825;5706.9714651426475;5716.371199168088;5777.595568310178;5826.2134611827705;5860.776572884896;5903.498202652737;5924.377940316291;5289.266106834361;5595.63628364155;5597.188407680864;5604.551635869121;5625.409332020079;3044.3302473455806;3062.540618907182;3097.6282846058166;3104.286014216743;3104.6740092289983;5644.915326270109;5853.795117170878;5898.380670029585;5943.613665111754;6089;5846.883062338729;5852.034414321674;5884;5889.911651325234;5910.822675319747;5953.821385358359;5983.850403739942;6065.2418447694035;6066.636001839815;6083.39166083397;5636.436356364495;5762.164486149569;5771.585961439474;5772.7402266898935;5781.710914454176;5705.743241554057;5775.826725198251;5780.624259423124;5785.846713541215;5789.465791565154;5745.712714364348;5973.313068996948;5985.072313791369;5998.940010599838;6057.848553786014;4785.569298762989;4819.204831202812;4838.685485443435;4854.466008738966;4854.75726213695;5685.005124103348;5693.003724348139;5786.855328616818;5800.854978625568;5860.619059761102;5646.85882852932;5651.689157096399;5660.15097735343;5665.778994649013;5678.346990096192;5330.600204984564;5662.462066103713;5667.319921609434;5680.261565996394;5680.943190568041;5544.584156188222;5552.750126244248;5556.111022236423;5635.492805647511;5645.576581756302;5578.944210558005;5683.545316374597;5745.683987380734;5750.281214848144;5794.507466865363;5480.835574932758;5496.972515137399;5570.3567447602245;5573.860653483695;5664.575156863334 09:47:56 INFO - PROCESS | 3429 | |5;yui.html;758.4804408979845;836.2807985132785;892.4556020827295;893.4907102951316;914.8930886333723;17261.741073883903;18114.909425452886;18176.909115454422;18289.99999999998;18301.725474117866;16947.406840760577;17406.651866962653;18146.274149034023;18957.33649322274;18979.2408303668;849.587949844325;858.712331368989;867.3754896474528;873.9650413983464;880.6213328268874;872.4198408058634;874.4796845876693;875.2472873328932;876.1501343696605;877.3156937588691;920.4293338130368;926.333040211047;927.7077720518015;928.749237705819;928.823523530527;912.7672443526891;913.488446469979;914.3690853311227;916.1662886773038;919.1084647891535;674.8953912143577;677.9559328643622;678.6504949950779;680.8400025993888;682.8941514065327;17154.485365439057;17248.741268880978;17358.305667773275;18063.548411289692;18322.63354732911;16301.91849040759;16310.918445407815;16316.75524867128;16392.426265080663;17079.658406831793;12931.288779117145;13346;13420.463181472729;13461.125026873222;13512.93243533776;4063.634272915422;4142.689298302639;4144.937825932613;4150.937735933933;4173.061061261223;54158.72920635411;54772.72613636906;78829.60585197095;81014;81668.59165704134;12484.438200281009;12897.613071607866;12955.935220323838;13009.21944683303;13096.541621043218;19711.310104146287;19924.203031878853;19956.800431995784;20033.298834541012;20189.596208075756;8746.34402419821;8934.106589341014;9032.954835225913;9125.361224714206;9186.58660360272;5277.155655095166;5286.180642000496;5352.2506849041165;5380;5421.864453388697;3632.654897784706;3687.1335236219466;3709.7217708671956;3713.4615480755137;3716.7955762433326;645.2128403347908;655.9737610495526;656.2748163279603;660.2967839251182;662.9569078009914;741.6588369350052;741.9406447484188;743.5315751076787;748.4162353364385;769.6228847864506;10263.178945684327;10697;10846.300832680618;10946.835797463045;10996.945015275032;769.0924708843506;782.7534326687075;786.6578038553248;800.3277247112453;803.9718609848627;5349.433184132121;5353.7590808413715;5384.353877534721;5388.757505912244;5436.592255580847;65964;66777;75833;80016.59991700004;81266;70841;72796.63601681958;74332.62833685905;76055;77581.22418775853;61825.9999999991;62559;67321;67925;68407;10907.345559266469;10947.288426252268;11333.376664283544;12012.63962081139;12346.938265308616;38558.228835423695;39525.60474395219;40818.38772418476;41521.584784151775;42076;50863;52454.47545524496;57115.71442142763;57176;58531.41468585259;13022;13243.536476223671;13310.600681979557;13612.183269003892;13913.791293130409;16032.438864639682;16096.597585060466;16149.75775363394;16188.919055404647;16251.756223656892;15588;15632.000796535434;15755.763663545285;15768;15864.60338491547;13703.862961370658;13829;13971.860281397056;15028.699426011637;15509.379624814881;14511.274436278354;14618.342174601956;15005;15300.61748456253;15474.767878482056;10039.648612298535;10300.381977081399;10672.786544269227;10862.565497380332;11005.449727513753;10213.84679229827;11470.827937580776;11611.245269057485;12008.339541325311;12099.939500302442 09:47:56 INFO - PROCESS | 3429 | __end_tp_report 09:47:56 INFO - PROCESS | 3429 | __start_cc_report 09:47:56 INFO - PROCESS | 3429 | _x_x_mozilla_cycle_collect,311 09:47:56 INFO - PROCESS | 3429 | __end_cc_report 09:47:56 INFO - PROCESS | 3429 | __startTimestamp1491842876644__endTimestamp 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | ------- Summary: start ------- 09:47:56 INFO - PROCESS | 3429 | Number of tests: 6 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#0] dojo.html Cycles:165 Average:5865.32 Median:6123.16 stddev:666.72 (10.9%) stddev-sans-first:639.94 09:47:56 INFO - PROCESS | 3429 | Values: 3393.2 3451.9 3460.5 3468.4 3485.5 5875.2 5907.9 5930.2 5945.3 5962.9 5851.6 5927.3 5937.6 5961.8 5964.2 5343.3 5404.8 5427.9 5440.8 5453.2 5364.0 5457.0 5463.3 5480.6 5485.9 5274.5 5282.5 5459.5 5474.2 5506.5 5326.1 5331.7 5355.4 5362.9 5397.8 5318.6 5393.4 5395.0 5410.8 5419.2 5689.7 5873.3 5904.5 5951.3 5964.0 6142.2 6205.9 6211.9 6221.0 6273.2 6399.3 6414.2 6416.3 6423.1 6423.2 5928.4 5947.9 5955.0 5964.4 5974.9 6099.0 6167.2 6296.0 6308.9 6361.2 6132.4 6206.2 6215.8 6223.7 6274.7 6315.4 6320.2 6353.3 6362.0 6363.9 6026.4 6078.1 6173.4 6178.1 6201.0 6280.8 6289.1 6304.1 6306.1 6328.3 4668.3 4697.2 4714.8 4749.6 4766.9 4209.7 4241.2 4243.3 4266.4 4276.1 6104.4 6144.7 6181.4 6204.6 6207.6 6343.1 6386.4 6391.9 6416.1 6419.5 5966.4 6191.3 6199.0 6202.8 6209.3 5322.9 5327.0 5334.4 5341.2 5367.7 6553.4 6568.2 6569.6 6579.4 6609.7 6408.6 6426.7 6426.9 6429.7 6441.6 6299.8 6331.9 6363.7 6406.5 6420.1 6157.7 6182.6 6187.4 6209.3 6213.8 6307.1 6309.2 6314.8 6325.7 6348.1 6027.6 6050.3 6093.1 6116.1 6118.6 6199.0 6210.5 6213.6 6216.8 6223.9 6098.9 6171.0 6191.2 6195.2 6198.1 6000.7 6020.6 6123.2 6151.7 6167.7 6065.4 6096.1 6103.5 6105.7 6131.3 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#1] ext.html Cycles:180 Average:46117.65 Median:31666.60 stddev:80044.73 (252.8%) stddev-sans-first:80196.85 09:47:56 INFO - PROCESS | 3429 | Values: 764.8 836.9 853.5 908.2 921.3 42632.8 42666.4 43074.4 43193.4 47113.8 44079.6 44203.1 44335.3 44548.3 44586.6 9091.3 10126.1 10393.9 10642.8 10713.8 10302.9 10317.8 10336.3 10364.3 10394.4 10433.4 10449.5 10491.0 10499.5 10525.2 10383.6 10416.8 10421.8 10456.7 10463.8 10224.5 10226.2 10278.1 10295.4 10301.3 35864.6 35939.3 35971.8 36030.8 36153.1 4121.5 4125.8 4170.7 4184.0 4228.4 27423.0 27480.3 27581.3 27589.6 28723.3 4295.0 4391.5 4415.6 4429.8 4461.6 228451.0 231235.0 236310.0 245458.0 246182.0 46712.5 47325.3 47485.1 47499.3 47604.8 49336.8 49449.0 49673.0 49680.5 49719.8 14393.1 14457.9 14490.7 14506.9 14510.5 12319.1 12347.4 12363.3 12368.3 12437.7 13131.1 13181.9 13189.5 13370.1 13431.1 5465.4 5508.2 5575.6 5584.3 5623.5 981.8 995.7 1009.7 1011.3 1012.9 28199.6 28200.9 28450.3 28802.9 28824.4 1074.6 1081.8 1103.4 1105.1 1114.0 14813.4 15008.5 15961.4 16822.8 17104.6 329929.0 331088.0 331721.0 332104.0 332448.0 52671.5 53012.5 53012.7 53067.5 53164.5 1464.6 1468.6 1487.2 1489.7 1502.2 28472.4 28906.0 28926.4 29531.6 29599.9 38982.6 39030.2 39095.8 39374.4 39425.6 336530.0 336608.0 337881.0 337988.0 338863.0 30268.8 30757.2 31354.8 32700.5 33436.8 39533.4 39865.4 40031.6 40065.2 40441.4 31706.8 31946.2 32105.7 32157.7 32565.9 31258.0 31340.2 31622.8 31718.7 31883.5 35205.6 35605.3 35678.3 35678.8 35824.8 30482.7 30611.2 31626.4 33915.3 33930.8 24410.8 25766.0 26009.5 26317.2 26600.2 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#2] jquery.html Cycles:180 Average:40297.00 Median:22062.67 stddev:123227.74 (558.5%) stddev-sans-first:123537.08 09:47:56 INFO - PROCESS | 3429 | Values: 435.5 450.9 457.1 465.3 472.8 18378.3 19779.6 20496.1 21880.3 22077.8 21500.5 21606.2 21976.5 22011.9 22548.8 6677.8 6752.3 6973.6 6980.1 6998.0 6842.9 6922.8 6964.4 6970.1 6984.0 6710.2 6853.0 6910.4 6952.4 6999.0 6694.8 6904.7 6919.2 6993.0 7018.9 6625.3 6653.2 6691.6 6692.5 6696.4 25481.2 25701.7 25917.0 26171.1 26296.5 3256.0 3329.1 3352.4 3653.5 3707.2 17659.6 18629.7 18933.8 18936.1 19211.0 2282.3 2347.9 2357.5 2387.6 2408.7 84109.2 87366.0 116042.4 118176.0 124220.5 21945.9 22047.6 22459.3 22674.9 22882.3 42134.6 42749.8 42829.6 43126.8 43138.6 9716.5 10081.8 10315.9 10356.4 10612.8 8559.7 8697.9 8758.6 8903.7 8905.4 9035.4 9349.7 9570.0 9638.0 9692.9 3462.0 3696.7 3789.3 4018.8 4086.2 1154.6 1167.0 1182.5 1183.9 1205.4 19359.4 20481.4 20528.7 20620.7 20689.6 1164.8 1164.9 1166.9 1184.6 1191.8 10654.8 11280.7 11395.3 11502.4 11521.4 741783.0 748405.0 752875.0 754961.0 759655.0 106316.0 110242.4 110383.4 110399.0 111381.0 1207.9 1242.3 1275.2 1278.0 1282.6 17682.0 17883.3 18058.8 18274.8 18416.9 40610.6 50706.7 50756.2 51351.5 53035.7 63808.7 64452.4 65134.3 65554.0 72696.6 9759.0 10925.9 12688.8 12913.6 13025.0 14400.1 14554.1 14738.6 14907.1 15135.2 12334.9 12377.0 12571.4 12595.7 12670.4 11275.4 11281.0 11314.6 11369.7 11545.9 12991.3 13040.7 13044.7 13134.3 13138.4 13158.3 13207.4 13219.9 13248.9 13266.5 12017.6 12820.4 12870.0 12925.0 12994.2 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#3] mootools.html Cycles:180 Average:7150.17 Median:2326.24 stddev:4574.91 (196.7%) stddev-sans-first:4568.40 09:47:56 INFO - PROCESS | 3429 | Values: 1550.9 1559.8 1576.6 1588.4 1610.8 10907.2 11627.7 11647.4 11771.7 12132.4 11793.1 11867.3 11935.5 11945.1 11958.5 2390.8 2402.1 2411.7 2420.0 2420.0 2342.0 2376.1 2459.5 2468.1 2470.2 2321.3 2331.1 2332.7 2461.3 2468.2 2236.6 2294.9 2294.9 2299.9 2356.4 2220.0 2240.5 2242.6 2243.4 2245.2 11559.8 11580.1 11611.9 11693.5 11717.4 5511.6 5794.2 5822.8 5826.9 5840.0 3469.9 3490.7 3517.9 3600.5 3619.2 1369.4 1369.4 1414.6 1428.3 1467.3 15135.3 15372.3 16122.3 17096.5 17334.1 4584.4 4612.3 4754.2 4768.6 4774.7 13530.9 13589.7 13591.3 13595.8 13645.6 5943.8 5975.3 5979.9 5983.2 5984.5 5408.8 5446.6 5469.2 5521.4 5549.3 4002.9 4074.2 4113.2 4117.3 4137.1 1046.1 1051.3 1071.6 1075.1 1082.3 1041.1 1057.2 1057.4 1066.3 1075.9 7381.1 7381.2 7397.3 7401.5 7589.3 1052.7 1056.1 1057.0 1062.4 1064.1 4398.2 4550.6 4584.1 4683.2 4712.2 14020.2 14530.8 14535.8 14554.9 14596.3 13904.3 14239.4 14307.9 14404.4 14405.6 8284.4 10844.8 11008.7 11056.6 11071.2 6316.7 7011.8 7031.6 7364.0 7596.3 13424.1 13629.1 13717.7 13731.0 13979.7 13300.8 13574.7 13611.8 13774.5 13777.2 9805.8 9808.9 9892.1 10007.9 10032.7 10811.1 10901.7 10937.8 10949.9 10955.0 8722.2 8722.8 8755.3 8790.1 8894.8 9012.4 9055.4 9071.6 9274.1 9294.9 7691.9 7713.4 7767.4 7796.6 7811.8 6281.9 6283.5 6295.5 6324.5 6327.1 6555.8 6581.2 6654.6 6709.9 6795.7 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#4] prototype.html Cycles:180 Average:4938.50 Median:5373.34 stddev:1305.87 (24.3%) stddev-sans-first:1264.52 09:47:56 INFO - PROCESS | 3429 | Values: 409.9 419.3 435.4 438.4 443.7 5201.4 5280.8 5352.4 5361.4 5385.2 5223.3 5268.3 5277.7 5286.4 5334.9 4573.8 4611.4 4615.8 4625.9 4651.8 4498.5 4562.7 4595.3 4605.7 4632.2 4556.6 4584.9 4595.3 4595.5 4611.0 4578.9 4584.6 4597.0 4610.9 4612.1 4025.3 4164.2 4428.3 4446.0 4447.5 5151.5 5151.9 5151.9 5155.8 5194.7 5153.8 5154.3 5188.7 5220.5 5230.7 5406.4 5613.5 5614.4 5641.5 5654.2 4702.4 4702.6 4708.6 4709.4 4709.8 5845.4 5847.5 5848.9 5873.4 5876.4 4633.9 4792.9 4793.8 4796.4 4818.5 4872.4 4885.5 4894.7 4895.4 4925.5 5202.3 5210.0 5218.3 5230.2 5304.6 5461.7 5592.7 5606.6 5636.8 5758.5 1645.3 1646.7 1665.2 1675.6 1687.6 1262.3 1310.5 1318.8 1322.7 1345.5 5572.0 5598.5 5602.1 5707.0 5716.4 5777.6 5826.2 5860.8 5903.5 5924.4 5289.3 5595.6 5597.2 5604.6 5625.4 3044.3 3062.5 3097.6 3104.3 3104.7 5644.9 5853.8 5898.4 5943.6 6089.0 5846.9 5852.0 5884.0 5889.9 5910.8 5953.8 5983.9 6065.2 6066.6 6083.4 5636.4 5762.2 5771.6 5772.7 5781.7 5705.7 5775.8 5780.6 5785.8 5789.5 5745.7 5973.3 5985.1 5998.9 6057.8 4785.6 4819.2 4838.7 4854.5 4854.8 5685.0 5693.0 5786.9 5800.9 5860.6 5646.9 5651.7 5660.2 5665.8 5678.3 5330.6 5662.5 5667.3 5680.3 5680.9 5544.6 5552.8 5556.1 5635.5 5645.6 5578.9 5683.5 5745.7 5750.3 5794.5 5480.8 5497.0 5570.4 5573.9 5664.6 09:47:56 INFO - PROCESS | 3429 | 09:47:56 INFO - PROCESS | 3429 | [#5] yui.html Cycles:180 Average:18055.43 Median:4147.94 stddev:21895.81 (527.9%) stddev-sans-first:21918.71 09:47:56 INFO - PROCESS | 3429 | Values: 758.5 836.3 892.5 893.5 914.9 17261.7 18114.9 18176.9 18290.0 18301.7 16947.4 17406.7 18146.3 18957.3 18979.2 849.6 858.7 867.4 874.0 880.6 872.4 874.5 875.2 876.2 877.3 920.4 926.3 927.7 928.7 928.8 912.8 913.5 914.4 916.2 919.1 674.9 678.0 678.7 680.8 682.9 17154.5 17248.7 17358.3 18063.5 18322.6 16301.9 16310.9 16316.8 16392.4 17079.7 12931.3 13346.0 13420.5 13461.1 13512.9 4063.6 4142.7 4144.9 4150.9 4173.1 54158.7 54772.7 78829.6 81014.0 81668.6 12484.4 12897.6 12955.9 13009.2 13096.5 19711.3 19924.2 19956.8 20033.3 20189.6 8746.3 8934.1 9033.0 9125.4 9186.6 5277.2 5286.2 5352.3 5380.0 5421.9 3632.7 3687.1 3709.7 3713.5 3716.8 645.2 656.0 656.3 660.3 663.0 741.7 741.9 743.5 748.4 769.6 10263.2 10697.0 10846.3 10946.8 10996.9 769.1 782.8 786.7 800.3 804.0 5349.4 5353.8 5384.4 5388.8 5436.6 65964.0 66777.0 75833.0 80016.6 81266.0 70841.0 72796.6 74332.6 76055.0 77581.2 61826.0 62559.0 67321.0 67925.0 68407.0 10907.3 10947.3 11333.4 12012.6 12346.9 38558.2 39525.6 40818.4 41521.6 42076.0 50863.0 52454.5 57115.7 57176.0 58531.4 13022.0 13243.5 13310.6 13612.2 13913.8 16032.4 16096.6 16149.8 16188.9 16251.8 15588.0 15632.0 15755.8 15768.0 15864.6 13703.9 13829.0 13971.9 15028.7 15509.4 14511.3 14618.3 15005.0 15300.6 15474.8 10039.6 10300.4 10672.8 10862.6 11005.4 10213.8 11470.8 11611.2 12008.3 12099.9 09:47:56 INFO - PROCESS | 3429 | -------- Summary: end -------- 09:47:56 INFO - PROCESS | 3429 | 09:47:57 INFO - TEST-INFO | 3429: exit 0 09:47:57 INFO - TEST-OK | dromaeo_css | took 1115139ms 09:47:57 INFO - TEST-START | kraken 09:47:57 INFO - operating with platform_type : linux_ 09:47:57 INFO - Initialising browser for kraken test... 09:47:57 INFO - TEST-INFO | started process 3808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TQaP0/profile http://localhost:43073/getInfo.html) 09:48:01 INFO - PROCESS | 3808 | __metrics Screen width/height:1600/1200 09:48:01 INFO - PROCESS | 3808 | colorDepth:24 09:48:01 INFO - PROCESS | 3808 | Browser inner width/height: 1024/697 09:48:01 INFO - PROCESS | 3808 | __metrics 09:48:02 ERROR - PROCESS | 3808 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 09:48:03 INFO - TEST-INFO | 3808: exit 0 09:48:03 INFO - Browser initialized. 09:48:03 INFO - Running cycle 1/1 for kraken test... 09:48:03 INFO - TEST-INFO | started process 3939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TQaP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:14 INFO - PROCESS | 3939 | RSS: Main: 146800640 09:48:14 INFO - PROCESS | 3939 | 09:48:17 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43073/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:18 INFO - PROCESS | 3939 | RSS: Main: 153317376 09:48:18 INFO - PROCESS | 3939 | 09:48:20 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43073/tests/kraken/driver.html?testName=audio-dft) 09:48:21 INFO - PROCESS | 3939 | RSS: Main: 152133632 09:48:21 INFO - PROCESS | 3939 | 09:48:24 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43073/tests/kraken/driver.html?testName=audio-fft) 09:48:25 INFO - PROCESS | 3939 | RSS: Main: 152649728 09:48:25 INFO - PROCESS | 3939 | 09:48:27 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43073/tests/kraken/driver.html?testName=audio-oscillator) 09:48:27 INFO - PROCESS | 3939 | RSS: Main: 152678400 09:48:27 INFO - PROCESS | 3939 | 09:48:29 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:48:30 INFO - PROCESS | 3939 | RSS: Main: 152461312 09:48:30 INFO - PROCESS | 3939 | 09:48:33 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43073/tests/kraken/driver.html?testName=imaging-darkroom) 09:48:34 INFO - PROCESS | 3939 | RSS: Main: 155115520 09:48:34 INFO - PROCESS | 3939 | 09:48:37 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43073/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:38 INFO - PROCESS | 3939 | RSS: Main: 155082752 09:48:38 INFO - PROCESS | 3939 | 09:48:40 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43073/tests/kraken/driver.html?testName=json-parse-financial) 09:48:41 INFO - PROCESS | 3939 | RSS: Main: 154955776 09:48:41 INFO - PROCESS | 3939 | 09:48:43 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:48:43 INFO - PROCESS | 3939 | RSS: Main: 154791936 09:48:43 INFO - PROCESS | 3939 | 09:48:45 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:48:46 INFO - PROCESS | 3939 | RSS: Main: 154624000 09:48:46 INFO - PROCESS | 3939 | 09:48:48 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:48:48 INFO - PROCESS | 3939 | RSS: Main: 154611712 09:48:48 INFO - PROCESS | 3939 | 09:48:51 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:48:52 INFO - PROCESS | 3939 | RSS: Main: 155164672 09:48:52 INFO - PROCESS | 3939 | 09:48:55 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:48:55 INFO - PROCESS | 3939 | RSS: Main: 155377664 09:48:55 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | Cycle 1(1): loaded http://localhost:43073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43073/tests/kraken/driver.html?testName=ai-astar) 09:48:57 INFO - PROCESS | 3939 | RSS: Main: 157540352 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | __start_tp_report 09:48:57 INFO - PROCESS | 3939 | _x_x_mozilla_page_load 09:48:57 INFO - PROCESS | 3939 | _x_x_mozilla_page_load_details 09:48:57 INFO - PROCESS | 3939 | |i|pagename|runs| 09:48:57 INFO - PROCESS | 3939 | |0;ai-astar;105;114;112;115;112;112;113;117;113;112 09:48:57 INFO - PROCESS | 3939 | |1;audio-beat-detection;142;118;119;160;121;117;120;123;132;121 09:48:57 INFO - PROCESS | 3939 | |2;audio-dft;162;162;164;161;162;162;160;162;166;167 09:48:57 INFO - PROCESS | 3939 | |3;audio-fft;79;78;76;128;76;76;75;76;95;75 09:48:57 INFO - PROCESS | 3939 | |4;audio-oscillator;82;82;113;88;82;82;94;83;81;107 09:48:57 INFO - PROCESS | 3939 | |5;imaging-gaussian-blur;114;113;113;115;115;113;113;113;113;114 09:48:57 INFO - PROCESS | 3939 | |6;imaging-darkroom;148;149;147;148;149;147;148;148;148;148 09:48:57 INFO - PROCESS | 3939 | |7;imaging-desaturate;94;95;95;95;94;95;94;95;94;95 09:48:57 INFO - PROCESS | 3939 | |8;json-parse-financial;60;59;61;61;62;59;62;59;59;60 09:48:57 INFO - PROCESS | 3939 | |9;json-stringify-tinderbox;53;55;53;54;57;53;58;54;54;53 09:48:57 INFO - PROCESS | 3939 | |10;stanford-crypto-aes;76;81;80;77;82;80;75;80;75;76 09:48:57 INFO - PROCESS | 3939 | |11;stanford-crypto-ccm;145;129;121;127;134;135;143;122;176;122 09:48:57 INFO - PROCESS | 3939 | |12;stanford-crypto-pbkdf2;156;156;164;161;162;157;163;157;164;162 09:48:57 INFO - PROCESS | 3939 | |13;stanford-crypto-sha256-iterative;60;61;60;60;60;59;59;60;57;62 09:48:57 INFO - PROCESS | 3939 | __end_tp_report 09:48:57 INFO - PROCESS | 3939 | __start_cc_report 09:48:57 INFO - PROCESS | 3939 | _x_x_mozilla_cycle_collect,790 09:48:57 INFO - PROCESS | 3939 | __end_cc_report 09:48:57 INFO - PROCESS | 3939 | __startTimestamp1491842937516__endTimestamp 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | ------- Summary: start ------- 09:48:57 INFO - PROCESS | 3939 | Number of tests: 14 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:3.10 (2.7%) stddev-sans-first:1.73 09:48:57 INFO - PROCESS | 3939 | Values: 105.0 114.0 112.0 115.0 112.0 112.0 113.0 117.0 113.0 112.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:122.00 stddev:13.82 (11.3%) stddev-sans-first:13.60 09:48:57 INFO - PROCESS | 3939 | Values: 142.0 118.0 119.0 160.0 121.0 117.0 120.0 123.0 132.0 121.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.20 (1.4%) stddev-sans-first:2.32 09:48:57 INFO - PROCESS | 3939 | Values: 162.0 162.0 164.0 161.0 162.0 162.0 160.0 162.0 166.0 167.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:16.77 (22.1%) stddev-sans-first:17.72 09:48:57 INFO - PROCESS | 3939 | Values: 79.0 78.0 76.0 128.0 76.0 76.0 75.0 76.0 95.0 75.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:11.64 (14.2%) stddev-sans-first:12.04 09:48:57 INFO - PROCESS | 3939 | Values: 82.0 82.0 113.0 88.0 82.0 82.0 94.0 83.0 81.0 107.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 09:48:57 INFO - PROCESS | 3939 | Values: 114.0 113.0 113.0 115.0 115.0 113.0 113.0 113.0 113.0 114.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:48:57 INFO - PROCESS | 3939 | Values: 148.0 149.0 147.0 148.0 149.0 147.0 148.0 148.0 148.0 148.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:48:57 INFO - PROCESS | 3939 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:1.23 (2.0%) stddev-sans-first:1.30 09:48:57 INFO - PROCESS | 3939 | Values: 60.0 59.0 61.0 61.0 62.0 59.0 62.0 59.0 59.0 60.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:1.78 (3.3%) stddev-sans-first:1.81 09:48:57 INFO - PROCESS | 3939 | Values: 53.0 55.0 53.0 54.0 57.0 53.0 58.0 54.0 54.0 53.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:80.00 stddev:2.66 (3.3%) stddev-sans-first:2.70 09:48:57 INFO - PROCESS | 3939 | Values: 76.0 81.0 80.0 77.0 82.0 80.0 75.0 80.0 75.0 76.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:16.59 (12.3%) stddev-sans-first:17.23 09:48:57 INFO - PROCESS | 3939 | Values: 145.0 129.0 121.0 127.0 134.0 135.0 143.0 122.0 176.0 122.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:162.00 stddev:3.33 (2.1%) stddev-sans-first:3.16 09:48:57 INFO - PROCESS | 3939 | Values: 156.0 156.0 164.0 161.0 162.0 157.0 163.0 157.0 164.0 162.0 09:48:57 INFO - PROCESS | 3939 | 09:48:57 INFO - PROCESS | 3939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.80 Median:60.00 stddev:1.32 (2.2%) stddev-sans-first:1.39 09:48:57 INFO - PROCESS | 3939 | Values: 60.0 61.0 60.0 60.0 60.0 59.0 59.0 60.0 57.0 62.0 09:48:57 INFO - PROCESS | 3939 | -------- Summary: end -------- 09:48:57 INFO - PROCESS | 3939 | 09:48:58 INFO - TEST-INFO | 3939: exit 0 09:48:58 INFO - TEST-OK | kraken | took 61197ms 09:48:58 INFO - SUITE-END | took 1176s 09:48:58 INFO - Completed test suite (00:19:36) 09:48:58 INFO - javascript benchmark 09:48:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7912.1764586675, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.236521782599, 3451.896443106706, 3460.4982277569743, 3468.3583537045647, 3485.546878905742, 5875.236219291492, 5907.881842363156, 5930.229070220876, 5945.346011938684, 5962.940370596293, 5851.561132915038, 5927.2590926134235, 5937.643741375509, 5961.791337303195, 5964.194833697449, 5343.332083489564, 5404.756785944642, 5427.864303392407, 5440.782368705247, 5453.2092846537225, 5364.007658583155, 5457.045017122007, 5463.289772329612, 5480.561555075605, 5485.862853428656, 5274.525292723654, 5282.5245727884485, 5459.481349271813, 5474.19110916545, 5506.504414602685, 5326.094563924162, 5331.680099194042, 5355.437679043684, 5362.865928351784, 5397.7571009304675, 5318.601104917108, 5393.379761327458, 5394.973025134888, 5410.783568657249, 5419.241306217133, 5689.7439615217, 5873.2658417697785, 5904.5276377890095, 5951.345352011275, 5964.015937370329, 6142.161149281699, 6205.937940620581, 6211.937880621181, 6220.968895155495, 6273.1531243282025, 6399.26408463028, 6414.198225221848, 6416.294207637156, 6423.068655044993, 6423.229212494531, 5928.3775203603, 5947.91078133824, 5955.0, 5964.373740757244, 5974.880502389928, 6099.0, 6167.198264225712, 6296.0, 6308.873822523524, 6361.236651601837, 6132.447291485777, 6206.224221972254, 6215.751369945152, 6223.688815559204, 6274.686265686697, 6315.431611155018, 6320.209973753281, 6353.269374021954, 6361.968190159019, 6363.9045414318825, 6026.427489388501, 6078.057901025348, 6173.444390004921, 6178.104174894615, 6200.968995154995, 6280.780172694025, 6289.0880822280515, 6304.054391841169, 6306.085617585424, 6328.272248691367, 4668.299755036772, 4697.248440249544, 4714.811407543729, 4749.596284315803, 4766.880827979328, 4209.684273679486, 4241.236577416094, 4243.257429949808, 4266.445362102907, 4276.123394704078, 6104.3590423005835, 6144.662043587646, 6181.412765787243, 6204.565680402418, 6207.6275423474735, 6343.111964324999, 6386.425221729974, 6391.872162556816, 6416.101745755598, 6419.454346380517, 5966.433188847052, 6191.318954914956, 6199.0, 6202.81391558254, 6209.2548894133, 5322.8935421292135, 5327.0411325961695, 5334.3865455473115, 5341.172118321666, 5367.731613419313, 6553.4101930826455, 6568.1789776277965, 6569.57297775643, 6579.440747536513, 6609.669516524058, 6408.551401401857, 6426.678666066771, 6426.903596446151, 6429.678516074271, 6441.581297215666, 6299.842503937255, 6331.9050214247745, 6363.745450181941, 6406.455451286693, 6420.069089981833, 6157.722902469489, 6182.629042257479, 6187.3503282154725, 6209.348018457997, 6213.844653883508, 6307.148534947723, 6309.242890852944, 6314.842128946813, 6325.746970121144, 6348.079528468438, 6027.638341699512, 6050.334463208956, 6093.055576385667, 6116.122740413025, 6118.571699980958, 6198.969005154945, 6210.534209934363, 6213.565050446426, 6216.7824126155365, 6223.875522489434, 6098.908516372347, 6170.981788004929, 6191.226096737908, 6195.2255968004, 6198.1012753149635, 6000.669963152069, 6020.638761674313, 6123.1606109212, 6151.661658608819, 6167.660778657038, 6065.423784740443, 6096.1465394845645, 6103.511719062376, 6105.725242364016, 6131.325554188947], "value": 5820.128261626804, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.8126209078777, 836.9330453563714, 853.5476197615264, 908.2234689340613, 921.2998121427721, 42632.786836065774, 42666.360004599956, 43074.353884691714, 43193.352099718526, 47113.76443117788, 44079.559204407946, 44203.11593768123, 44335.334969975476, 44548.33177502332, 44586.554134458645, 9091.27269818413, 10126.139278161365, 10393.896061039368, 10642.78714425711, 10713.839292410581, 10302.896971030306, 10317.793644127112, 10336.328138671, 10364.326318789255, 10394.428306443142, 10433.373997560133, 10449.477526123701, 10490.950904909525, 10499.475026248696, 10525.157987360994, 10383.636572719955, 10416.791664166713, 10421.79156416875, 10456.738581535446, 10463.843042354332, 10224.539895704711, 10226.181905447545, 10278.126359259471, 10295.433751143684, 10301.330413523097, 35864.56541738327, 35939.28121437583, 35971.82014089913, 36030.81984590086, 36153.09617259563, 4121.5466298707115, 4125.834966601333, 4170.749755014709, 4184.037671335579, 4228.365745138223, 27423.0, 27480.312992175157, 27581.31046723828, 27589.58615620767, 28723.27660340386, 4294.9785251073545, 4391.538888416734, 4415.558444155591, 4429.844955426544, 4461.598456138963, 228451.0, 231235.0, 236310.0, 245458.0, 246182.0, 46712.53287467082, 47325.29012064822, 47485.050298993825, 47499.28751068737, 47604.76197619059, 49336.75331623319, 49449.0, 49673.0, 49680.50319496831, 49719.751401243484, 14393.136411815325, 14457.92771036138, 14490.710185796224, 14506.927465362605, 14510.492132775513, 12319.137660363867, 12347.38263086842, 12363.258204507758, 12368.257904525757, 12437.689057773629, 13131.146475479254, 13181.868181318256, 13189.472421103048, 13370.06409551322, 13431.12697674648, 5465.4261302563455, 5508.228847961289, 5575.553955683536, 5584.301962254718, 5623.493885550321, 981.8281800684852, 995.7311525887969, 1009.7122320138725, 1011.3072545306488, 1012.8733908261468, 28199.57700634492, 28200.85899570489, 28450.288742781595, 28802.855985719936, 28824.42351152965, 1074.6346242277664, 1081.7836432713332, 1103.3545375955157, 1105.082781291526, 1113.9974023379025, 14813.407463701547, 15008.549743507712, 15961.36154553828, 16822.831771682126, 17104.572385690208, 329929.0, 331088.0, 331721.0, 332104.0, 332448.0, 52671.47328526742, 53012.469875300754, 53012.73493632507, 53067.46932530625, 53164.46835531673, 1464.5899148238511, 1468.5594321703447, 1487.248939285654, 1489.6573788028813, 1502.2113390469872, 28472.430551389272, 28906.0, 28926.421471570873, 29531.557026644186, 29599.85200073986, 38982.6101738979, 39030.21939561136, 39095.80452097721, 39374.409383859835, 39425.60574394219, 336530.0, 336608.0, 337881.0, 337988.0, 338863.0, 30268.84865575658, 30757.23106922345, 31354.843225783727, 32700.50949235811, 33436.83281583576, 39533.40699889446, 39865.40201897032, 40031.59968400279, 40065.1986960265, 40441.39337909875, 31706.841465792524, 31946.20134496656, 32105.67894321027, 32157.678423216403, 32565.88321759078, 31258.0, 31340.216494587818, 31622.841885790425, 31718.682813171574, 31883.521747174276, 35205.64794352126, 35605.28789424249, 35678.286434271686, 35678.821605892845, 35824.82087589546, 30482.695173048873, 30611.23471913131, 31626.36747265088, 33915.32169356648, 33930.8303458491, 24410.755892440848, 25766.0, 26009.479810404064, 26317.21048368552, 26600.201993940213], "value": 18598.55560956899, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.4948260018379, 450.8827704796752, 457.06758213244984, 465.31598550131315, 472.83450792222726, 18378.264869405226, 19779.604407911833, 20496.077676504556, 21880.343589692315, 22077.779222207773, 21500.46248843776, 21606.243781467652, 21976.45058873529, 22011.889940550314, 22548.774512254873, 6677.766278180253, 6752.324767523258, 6973.581585104885, 6980.127484064492, 6997.965010174942, 6842.897356539655, 6922.753904297225, 6964.373206411422, 6970.09388779458, 6984.0, 6710.16122984627, 6853.0, 6910.4471642268745, 6952.374286314256, 6999.0, 6694.765683201064, 6904.654767261642, 6919.204291506466, 6992.965035174842, 7018.89471657923, 6625.3043430440075, 6653.201615806134, 6691.631960242234, 6692.531522793406, 6696.430803381719, 25481.235562933143, 25701.742982570122, 25917.0, 26171.084012059488, 26296.474070518674, 3255.983720081408, 3329.1137978809156, 3352.4133276676484, 3653.488511608377, 3707.1658876752786, 17659.646807063786, 18629.7205541917, 18933.81066189334, 18936.147873345733, 19211.0, 2282.2924893283134, 2347.917822876208, 2357.5167090746527, 2387.594109001474, 2408.747081556429, 84109.15890841074, 87366.0, 116042.41978790052, 118176.0, 124220.49888071552, 21945.912031112373, 22047.559048818934, 22459.32622021342, 22674.886625566767, 22882.31353059411, 42134.57865421368, 42749.78625106917, 42829.571704282556, 43126.784366078595, 43138.568614314085, 9716.465594392235, 10081.798364032678, 10315.896841031643, 10356.378617282988, 10612.787744245072, 8559.74320770378, 8697.851323273462, 8758.605862736193, 8903.688370907117, 8905.421147625384, 9035.412698174598, 9349.719508414759, 9569.952150239204, 9637.951810240904, 9692.903070969342, 3461.962844061884, 3696.7302765306113, 3789.2610940866266, 4018.7588744675413, 4086.1827634473225, 1154.630518234174, 1166.9591564295208, 1182.4501606752729, 1183.8875306845837, 1205.427421974555, 19359.4192174235, 20481.38555843327, 20528.692069618966, 20620.69068963967, 20689.58620827575, 1164.7554013657057, 1164.889335513125, 1166.854143232096, 1184.5972369394276, 1191.8212268159846, 10654.840177397346, 11280.717982050515, 11395.316281023164, 11502.367369794742, 11521.423928803526, 741783.0, 748405.0, 752875.0, 754961.0, 759655.0, 106316.0, 110242.44878775715, 110383.44808275907, 110399.0, 111381.0, 1207.8610959739742, 1242.3105176626877, 1275.2093701904878, 1278.015927735657, 1282.6472720002075, 17682.0, 17883.28466861311, 18058.81941180624, 18274.817251827313, 18416.90791546034, 40610.59389406068, 50706.74646626891, 50756.23865642092, 51351.48648513467, 53035.73482132565, 63808.68095659492, 64452.35547644651, 65134.348656514725, 65554.0, 72696.63651681707, 9759.0, 10925.90740925901, 12688.809667855174, 12913.612591622266, 13025.0, 14400.063995840237, 14554.12675239489, 14738.63153421173, 14907.105573665614, 15135.243237837843, 12334.938325308316, 12377.0, 12571.371431428575, 12595.748085038065, 12670.429830657828, 11275.379854108103, 11281.0, 11314.60398886035, 11369.658910232707, 11545.942270288595, 12991.28547929873, 13040.739185216433, 13044.739105218032, 13134.277614731282, 13138.408771605491, 13158.342082895626, 13207.405666744828, 13219.867801321863, 13248.933755331162, 13266.53567125146, 12017.63947081589, 12820.423080961566, 12870.0, 12925.0, 12994.220346779224], "value": 11833.7689251037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.8836837237207, 1559.8440155984397, 1576.6216108134038, 1588.372592825834, 1610.7825443565116, 10907.181961352891, 11627.651170464878, 11647.35939523326, 11771.70570735732, 12132.393380330992, 11793.115516336266, 11867.287962722243, 11935.462904169312, 11945.104117191224, 11958.521659133647, 2390.8445951013173, 2402.0992127952018, 2411.6744239527616, 2419.9516009679883, 2419.9879000604974, 2342.0, 2376.085207195225, 2459.5080983803223, 2468.111479867255, 2470.1848390031246, 2321.3384185507134, 2331.137479132715, 2332.650102484624, 2461.3477428481465, 2468.2348471973746, 2236.630955892276, 2294.8967296471615, 2294.9311520654405, 2299.862008279492, 2356.422676444282, 2220.0, 2240.5182885679496, 2242.5963326601204, 2243.4391402149463, 2245.2029529517113, 11559.76880462386, 11580.131490138188, 11611.94194029033, 11693.473793679304, 11717.414129293586, 5511.58663100269, 5794.217780599607, 5822.767089316422, 5826.912596311059, 5839.970800146015, 3469.9479507807405, 3490.703290220334, 3517.8944631661093, 3600.4959305697225, 3619.1856832212807, 1369.3906211735782, 1369.4179973511218, 1414.5897689669982, 1428.300132934865, 1467.347030571396, 15135.318910649048, 15372.30824612895, 16122.274497647633, 17096.487105386735, 17334.133293335282, 4584.358189853423, 4612.262038073892, 4754.191787396151, 4768.57082862544, 4774.7135171889795, 13530.932345338408, 13589.660258493617, 13591.320433978262, 13595.796063059062, 13645.590632281048, 5943.791967281124, 5975.282966044103, 5979.880402392015, 5983.19226904371, 5984.461398474158, 5408.7566059526625, 5446.564274858002, 5469.15228139639, 5521.420250873601, 5549.306336707911, 4002.8598999034893, 4074.2055299216963, 4113.239050775556, 4117.2588933992165, 4137.13120244752, 1046.0899017854515, 1051.2851261142343, 1071.5927947379946, 1075.0754351257913, 1082.3019152646498, 1041.13065590233, 1057.2387880725864, 1057.381431862369, 1066.344198318029, 1075.8977897099762, 7381.077365329334, 7381.1511676157925, 7397.297256760599, 7401.518901271508, 7589.316961473494, 1052.6578861869923, 1056.1181413519796, 1056.957721691139, 1062.3997441445558, 1064.0724322930619, 4398.186335527937, 4550.613197878218, 4584.106099310602, 4683.227267500824, 4712.24604063355, 14020.228887411291, 14530.782038269223, 14535.78196327056, 14554.927225363805, 14596.270186490632, 13904.304784760721, 14239.43042278318, 14307.856921430652, 14404.423823047171, 14405.639859003399, 8284.420090593721, 10844.783104337868, 11008.669739907815, 11056.613018544473, 11071.225014248925, 6316.652584107918, 7011.789646310619, 7031.624820086285, 7363.963180184065, 7596.278353556403, 13424.127431717297, 13629.114107582975, 13717.725645487233, 13731.038827281995, 13979.720405591628, 13300.800487992881, 13574.660633484242, 13611.79582306286, 13774.517891873737, 13777.173369597856, 9805.803883922139, 9808.9019109808, 9892.109710126124, 10007.899921000697, 10032.69901902944, 10811.135109191404, 10901.672949811518, 10937.781244375226, 10949.890501094887, 10955.0, 8722.215000649972, 8722.825543489222, 8755.255803256794, 8790.120987901159, 8894.777630559287, 9012.369134160546, 9055.36612437123, 9071.637134514545, 9274.118958698913, 9294.860577091484, 7691.884621730566, 7713.421493387906, 7767.378609711097, 7796.610169491616, 7811.765647030598, 6281.937180628135, 6283.528735344776, 6295.464885484602, 6324.4940404766585, 6327.082573026793, 6555.770548030796, 6581.177352830896, 6654.567453115726, 6709.914746600971, 6795.694193761392], "value": 5402.314721445363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.8667932921801, 419.3311667889715, 435.3817579037768, 438.3731264292062, 443.72267332916914, 5201.375834899808, 5280.815171468999, 5352.384475785286, 5361.437049109846, 5385.246065550821, 5223.320968274129, 5268.262443257938, 5277.656952298098, 5286.392064912537, 5334.946045772386, 4573.7713114344315, 4611.446626404836, 4615.769211539427, 4625.930611040837, 4651.767411629422, 4498.460184777831, 4562.749048802315, 4595.333676616889, 4605.700629459075, 4632.235681112612, 4556.587457888048, 4584.908301833962, 4595.333676616889, 4595.517470665583, 4611.0, 4578.908421831561, 4584.610308123813, 4596.954030459686, 4610.907781844345, 4612.1090352955125, 4025.275450418953, 4164.208800327959, 4428.335749637548, 4445.955540444619, 4447.51077381491, 5151.484851514856, 5151.896962060775, 5151.922721159186, 5155.767990440401, 5194.71429071401, 5153.845384638467, 5154.278401023859, 5188.688678679291, 5220.504052115043, 5230.686158830445, 5406.405295417501, 5613.46672066153, 5614.438556144353, 5641.464060914206, 5654.236678048452, 4702.365180700596, 4702.612729244881, 4708.552687494683, 4709.364235828154, 4709.811607535695, 5845.386234445365, 5847.502962248172, 5848.853778655568, 5873.412658734135, 5876.382979787147, 4633.907321853544, 4792.904141917142, 4793.784279707352, 4796.426662136731, 4818.458093410075, 4872.43966943806, 4885.511448855086, 4894.681845680019, 4895.363602731622, 4925.458199598042, 5202.283246528712, 5209.973950130301, 5218.347706536683, 5230.215467679803, 5304.594282515137, 5461.672299661954, 5592.720363981784, 5606.617187695213, 5636.774529018793, 5758.481736643722, 1645.2514106081944, 1646.6788976149535, 1665.2173478465345, 1675.589480577242, 1687.5949772054619, 1262.3372729317182, 1310.4561606933016, 1318.815365848782, 1322.7486777512242, 1345.468539926743, 5572.0, 5598.5086636446395, 5602.12328869825, 5706.9714651426475, 5716.371199168088, 5777.595568310178, 5826.2134611827705, 5860.776572884896, 5903.498202652737, 5924.377940316291, 5289.266106834361, 5595.63628364155, 5597.188407680864, 5604.551635869121, 5625.409332020079, 3044.3302473455806, 3062.540618907182, 3097.6282846058166, 3104.286014216743, 3104.6740092289983, 5644.915326270109, 5853.795117170878, 5898.380670029585, 5943.613665111754, 6089.0, 5846.883062338729, 5852.034414321674, 5884.0, 5889.911651325234, 5910.822675319747, 5953.821385358359, 5983.850403739942, 6065.2418447694035, 6066.636001839815, 6083.39166083397, 5636.436356364495, 5762.164486149569, 5771.585961439474, 5772.7402266898935, 5781.710914454176, 5705.743241554057, 5775.826725198251, 5780.624259423124, 5785.846713541215, 5789.465791565154, 5745.712714364348, 5973.313068996948, 5985.072313791369, 5998.940010599838, 6057.848553786014, 4785.569298762989, 4819.204831202812, 4838.685485443435, 4854.466008738966, 4854.75726213695, 5685.005124103348, 5693.003724348139, 5786.855328616818, 5800.854978625568, 5860.619059761102, 5646.85882852932, 5651.689157096399, 5660.15097735343, 5665.778994649013, 5678.346990096192, 5330.600204984564, 5662.462066103713, 5667.319921609434, 5680.261565996394, 5680.943190568041, 5544.584156188222, 5552.750126244248, 5556.111022236423, 5635.492805647511, 5645.576581756302, 5578.944210558005, 5683.545316374597, 5745.683987380734, 5750.281214848144, 5794.507466865363, 5480.835574932758, 5496.972515137399, 5570.3567447602245, 5573.860653483695, 5664.575156863334], "value": 4557.976964325173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.4804408979845, 836.2807985132785, 892.4556020827295, 893.4907102951316, 914.8930886333723, 17261.741073883903, 18114.909425452886, 18176.909115454422, 18289.99999999998, 18301.725474117866, 16947.406840760577, 17406.651866962653, 18146.274149034023, 18957.33649322274, 18979.2408303668, 849.587949844325, 858.712331368989, 867.3754896474528, 873.9650413983464, 880.6213328268874, 872.4198408058634, 874.4796845876693, 875.2472873328932, 876.1501343696605, 877.3156937588691, 920.4293338130368, 926.333040211047, 927.7077720518015, 928.749237705819, 928.823523530527, 912.7672443526891, 913.488446469979, 914.3690853311227, 916.1662886773038, 919.1084647891535, 674.8953912143577, 677.9559328643622, 678.6504949950779, 680.8400025993888, 682.8941514065327, 17154.485365439057, 17248.741268880978, 17358.305667773275, 18063.548411289692, 18322.63354732911, 16301.91849040759, 16310.918445407815, 16316.75524867128, 16392.426265080663, 17079.658406831793, 12931.288779117145, 13346.0, 13420.463181472729, 13461.125026873222, 13512.93243533776, 4063.634272915422, 4142.689298302639, 4144.937825932613, 4150.937735933933, 4173.061061261223, 54158.72920635411, 54772.72613636906, 78829.60585197095, 81014.0, 81668.59165704134, 12484.438200281009, 12897.613071607866, 12955.935220323838, 13009.21944683303, 13096.541621043218, 19711.310104146287, 19924.203031878853, 19956.800431995784, 20033.298834541012, 20189.596208075756, 8746.34402419821, 8934.106589341014, 9032.954835225913, 9125.361224714206, 9186.58660360272, 5277.155655095166, 5286.180642000496, 5352.2506849041165, 5380.0, 5421.864453388697, 3632.654897784706, 3687.1335236219466, 3709.7217708671956, 3713.4615480755137, 3716.7955762433326, 645.2128403347908, 655.9737610495526, 656.2748163279603, 660.2967839251182, 662.9569078009914, 741.6588369350052, 741.9406447484188, 743.5315751076787, 748.4162353364385, 769.6228847864506, 10263.178945684327, 10697.0, 10846.300832680618, 10946.835797463045, 10996.945015275032, 769.0924708843506, 782.7534326687075, 786.6578038553248, 800.3277247112453, 803.9718609848627, 5349.433184132121, 5353.7590808413715, 5384.353877534721, 5388.757505912244, 5436.592255580847, 65964.0, 66777.0, 75833.0, 80016.59991700004, 81266.0, 70841.0, 72796.63601681958, 74332.62833685905, 76055.0, 77581.22418775853, 61825.9999999991, 62559.0, 67321.0, 67925.0, 68407.0, 10907.345559266469, 10947.288426252268, 11333.376664283544, 12012.63962081139, 12346.938265308616, 38558.228835423695, 39525.60474395219, 40818.38772418476, 41521.584784151775, 42076.0, 50863.0, 52454.47545524496, 57115.71442142763, 57176.0, 58531.41468585259, 13022.0, 13243.536476223671, 13310.600681979557, 13612.183269003892, 13913.791293130409, 16032.438864639682, 16096.597585060466, 16149.75775363394, 16188.919055404647, 16251.756223656892, 15588.0, 15632.000796535434, 15755.763663545285, 15768.0, 15864.60338491547, 13703.862961370658, 13829.0, 13971.860281397056, 15028.699426011637, 15509.379624814881, 14511.274436278354, 14618.342174601956, 15005.0, 15300.61748456253, 15474.767878482056, 10039.648612298535, 10300.381977081399, 10672.786544269227, 10862.565497380332, 11005.449727513753, 10213.84679229827, 11470.827937580776, 11611.245269057485, 12008.339541325311, 12099.939500302442], "value": 7777.716089141996, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 115.0, 112.0, 112.0, 113.0, 117.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 119.0, 160.0, 121.0, 117.0, 120.0, 123.0, 132.0, 121.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 162.0, 160.0, 162.0, 166.0, 167.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 76.0, 128.0, 76.0, 76.0, 75.0, 76.0, 95.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 88.0, 82.0, 82.0, 94.0, 83.0, 81.0, 107.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 115.0, 115.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 61.0, 62.0, 59.0, 62.0, 59.0, 59.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 57.0, 53.0, 58.0, 54.0, 54.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 80.0, 77.0, 82.0, 80.0, 75.0, 80.0, 75.0, 76.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 129.0, 121.0, 127.0, 134.0, 135.0, 143.0, 122.0, 176.0, 122.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 164.0, 161.0, 162.0, 157.0, 163.0, 157.0, 164.0, 162.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 57.0, 62.0], "value": 59.8, "unit": "score"}]}]} 09:48:58 INFO - Return code: 0 09:48:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:48:58 ERROR - # TBPL SUCCESS # 09:48:58 INFO - Running post-action listener: _resource_record_post_action 09:48:58 INFO - [mozharness: 2017-04-10 16:48:58.842086Z] Finished run-tests step (success) 09:48:58 INFO - Running post-run listener: _resource_record_post_run 09:48:58 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8015872; Write bytes: 371449856; Read time: 1948; Write time: 252024 09:48:58 INFO - TinderboxPrint: CPU usage
13.5% 09:48:58 INFO - TinderboxPrint: I/O read bytes / time
8,015,872 / 1,948 09:48:58 INFO - TinderboxPrint: I/O write bytes / time
371,449,856 / 252,024 09:48:58 INFO - TinderboxPrint: CPU idle
8,238.4 (86.5%) 09:48:58 INFO - TinderboxPrint: CPU user
1,221.0 (12.8%) 09:48:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:48:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116473856; Read time: 0; Write time: 96780 09:48:58 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6135808; Write bytes: 254976000; Read time: 1572; Write time: 155244 09:48:59 INFO - Running post-run listener: _upload_blobber_files 09:48:59 INFO - Blob upload gear active. 09:48:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:48:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:48:59 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:48:59 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:48:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:00 INFO - (blobuploader) - INFO - Done attempting. 09:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:04 INFO - (blobuploader) - INFO - Done attempting. 09:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:05 INFO - (blobuploader) - INFO - Done attempting. 09:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:49:05 INFO - (blobuploader) - INFO - Done attempting. 09:49:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:49:05 INFO - Return code: 0 09:49:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:49:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:49:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/360f6a411811ecc8357e0065d40febb3c87426e0a69e3a6d4a07800a46852feccec1f81ed65c221ce123bb53fe13e38319f3e6b864eeda3edd7c3568d5111a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/014b579d48a706e568ff89ccfe3a40ab7f28e719b9010eda242ec19b454ad67e61f10de035d46d800d4ed913670d26c9cda9d058677f1c2536ad727c1f711ae1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/19cf5880d529b62c93f6e9438a488c75b54cdd9f32961a08899171dc1a5bb0fdd35ee4c6d04a9c761fc29f485c04abcbaaf8d17c249ded0168538e13c479aae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f56dfadd814ae048502205f5276746b1fd9747c6f3bb81da158c8e11cf6ea443aacf6bfae27ab2c732ff1f36519faf9f323af92d2c4c06aace78fc691e98a70"} 09:49:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:49:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:49:05 INFO - Contents: 09:49:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/360f6a411811ecc8357e0065d40febb3c87426e0a69e3a6d4a07800a46852feccec1f81ed65c221ce123bb53fe13e38319f3e6b864eeda3edd7c3568d5111a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/014b579d48a706e568ff89ccfe3a40ab7f28e719b9010eda242ec19b454ad67e61f10de035d46d800d4ed913670d26c9cda9d058677f1c2536ad727c1f711ae1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/19cf5880d529b62c93f6e9438a488c75b54cdd9f32961a08899171dc1a5bb0fdd35ee4c6d04a9c761fc29f485c04abcbaaf8d17c249ded0168538e13c479aae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f56dfadd814ae048502205f5276746b1fd9747c6f3bb81da158c8e11cf6ea443aacf6bfae27ab2c732ff1f36519faf9f323af92d2c4c06aace78fc691e98a70"} 09:49:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:49:05 INFO - Copying logs to upload dir... 09:49:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:49:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.998660 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-04-10 09:49:06.049474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 09:49:06.053471) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/360f6a411811ecc8357e0065d40febb3c87426e0a69e3a6d4a07800a46852feccec1f81ed65c221ce123bb53fe13e38319f3e6b864eeda3edd7c3568d5111a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/014b579d48a706e568ff89ccfe3a40ab7f28e719b9010eda242ec19b454ad67e61f10de035d46d800d4ed913670d26c9cda9d058677f1c2536ad727c1f711ae1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/19cf5880d529b62c93f6e9438a488c75b54cdd9f32961a08899171dc1a5bb0fdd35ee4c6d04a9c761fc29f485c04abcbaaf8d17c249ded0168538e13c479aae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f56dfadd814ae048502205f5276746b1fd9747c6f3bb81da158c8e11cf6ea443aacf6bfae27ab2c732ff1f36519faf9f323af92d2c4c06aace78fc691e98a70"} build_url:https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/CW4O1OIPSIiA1vtrFWHmxw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/360f6a411811ecc8357e0065d40febb3c87426e0a69e3a6d4a07800a46852feccec1f81ed65c221ce123bb53fe13e38319f3e6b864eeda3edd7c3568d5111a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/014b579d48a706e568ff89ccfe3a40ab7f28e719b9010eda242ec19b454ad67e61f10de035d46d800d4ed913670d26c9cda9d058677f1c2536ad727c1f711ae1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/19cf5880d529b62c93f6e9438a488c75b54cdd9f32961a08899171dc1a5bb0fdd35ee4c6d04a9c761fc29f485c04abcbaaf8d17c249ded0168538e13c479aae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f56dfadd814ae048502205f5276746b1fd9747c6f3bb81da158c8e11cf6ea443aacf6bfae27ab2c732ff1f36519faf9f323af92d2c4c06aace78fc691e98a70"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 09:49:06.108402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:49:06.108728) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1491841686.90562-944436544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:49:06.226825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 09:49:06.227144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 09:49:06.227475) ========= ========= Total master_lag: 0.39 =========