builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1480705569.06 results: success (0) buildid: 20161202090743 builduid: eddbd000e0cb4ac0a6b682b627b4fdce revision: c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.059451) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.060518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.061236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.076822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.077117) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 11:06:09-- 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% 229M=0s 2016-12-02 11:06:09 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.216665) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.217492) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.268496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:09.268928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 --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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 11:06:09,648 truncating revision to first 12 chars 2016-12-02 11:06:09,648 Setting DEBUG logging. 2016-12-02 11:06:09,648 attempt 1/10 2016-12-02 11:06:09,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c491aa9d4537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 11:06:10,163 unpacking tar archive at: mozilla-beta-c491aa9d4537/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:10.117604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:10.118389) ========= script_repo_revision: c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:10.119247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:10.119986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 11:06:10.131104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-12-02 11:06:10.131450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:10 INFO - MultiFileLogger online at 20161202 11:06:10 in /builds/slave/test 11:06:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:06:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:10 INFO - {'append_to_log': False, 11:06:10 INFO - 'base_work_dir': '/builds/slave/test', 11:06:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:06:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:10 INFO - 'branch': 'Mozilla-Beta', 11:06:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:10 INFO - 'config_files': ('talos/linux_config.py',), 11:06:10 INFO - 'default_actions': ('clobber', 11:06:10 INFO - 'read-buildbot-config', 11:06:10 INFO - 'download-and-extract', 11:06:10 INFO - 'populate-webroot', 11:06:10 INFO - 'create-virtualenv', 11:06:10 INFO - 'install', 11:06:10 INFO - 'run-tests'), 11:06:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:10 INFO - 'download_minidump_stackwalk': True, 11:06:10 INFO - 'download_symbols': 'ondemand', 11:06:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:10 INFO - 'installer_path': 'installer.exe', 11:06:10 INFO - 'log_level': 'info', 11:06:10 INFO - 'log_name': 'talos', 11:06:10 INFO - 'log_to_console': True, 11:06:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:10 INFO - 'opt_config_files': (), 11:06:10 INFO - 'pip_index': False, 11:06:10 INFO - 'sps_profile': False, 11:06:10 INFO - 'sps_profile_interval': 0, 11:06:10 INFO - 'suite': 'dromaeojs', 11:06:10 INFO - 'system_bits': '32', 11:06:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:10 INFO - 'title': 'talos-linux64-ix-068', 11:06:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:10 INFO - 'use_talos_json': True, 11:06:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:10 INFO - 'work_dir': 'build'} 11:06:10 INFO - [mozharness: 2016-12-02 19:06:10.609120Z] Running clobber step. 11:06:10 INFO - Running pre-action listener: _resource_record_pre_action 11:06:10 INFO - Running main action method: clobber 11:06:10 INFO - rmtree: /builds/slave/test/build 11:06:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:11 INFO - Running post-action listener: _resource_record_post_action 11:06:11 INFO - [mozharness: 2016-12-02 19:06:11.585754Z] Finished clobber step (success) 11:06:11 INFO - [mozharness: 2016-12-02 19:06:11.585854Z] Running read-buildbot-config step. 11:06:11 INFO - Running pre-action listener: _resource_record_pre_action 11:06:11 INFO - Running main action method: read_buildbot_config 11:06:11 INFO - Using buildbot properties: 11:06:11 INFO - { 11:06:11 INFO - "project": "", 11:06:11 INFO - "product": "firefox", 11:06:11 INFO - "script_repo_revision": "production", 11:06:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:06:11 INFO - "repository": "", 11:06:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:06:11 INFO - "buildid": "20161202090743", 11:06:11 INFO - "pgo_build": "True", 11:06:11 INFO - "basedir": "/builds/slave/test", 11:06:11 INFO - "buildnumber": 490, 11:06:11 INFO - "slavename": "talos-linux64-ix-068", 11:06:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:11 INFO - "platform": "ubuntu64_hw", 11:06:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:06:11 INFO - "branch": "mozilla-beta", 11:06:11 INFO - "repo_path": "releases/mozilla-beta", 11:06:11 INFO - "revision": "c491aa9d45371e2d0122a4a8ffbc5a250a8bb855", 11:06:11 INFO - "stage_platform": "linux64-pgo", 11:06:11 INFO - "builduid": "eddbd000e0cb4ac0a6b682b627b4fdce", 11:06:11 INFO - "slavebuilddir": "test" 11:06:11 INFO - } 11:06:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 11:06:11 INFO - Running post-action listener: _resource_record_post_action 11:06:11 INFO - [mozharness: 2016-12-02 19:06:11.588342Z] Finished read-buildbot-config step (success) 11:06:11 INFO - [mozharness: 2016-12-02 19:06:11.588430Z] Running download-and-extract step. 11:06:11 INFO - Running pre-action listener: _resource_record_pre_action 11:06:11 INFO - Running main action method: download_and_extract 11:06:11 INFO - mkdir: /builds/slave/test/build/tests 11:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:11 INFO - trying https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:06:11 INFO - Downloading https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:06:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:12 INFO - Downloaded 1327 bytes. 11:06:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:06:12 INFO - Using the following test package requirements: 11:06:12 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 11:06:12 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:12 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 11:06:12 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'jsshell-linux-x86_64.zip'], 11:06:12 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:12 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 11:06:12 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 11:06:12 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 11:06:12 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:12 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:06:12 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:12 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 11:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 11:06:12 INFO - Expected file size: 21964043 11:06:16 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:06:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 11:06:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:16 INFO - Fetch https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 11:06:17 INFO - Expected file size: 21964043 11:06:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 11:06:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:06:22 INFO - Fetch https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 11:06:22 INFO - Expected file size: 14414089 11:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:23 INFO - trying https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:23 INFO - Downloading https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:06:24 INFO - Downloaded 56975024 bytes. 11:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:24 INFO - mkdir: /builds/slave/test/properties 11:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:24 INFO - Contents: 11:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:24 INFO - Running post-action listener: _resource_record_post_action 11:06:24 INFO - Running post-action listener: set_extra_try_arguments 11:06:24 INFO - [mozharness: 2016-12-02 19:06:24.768869Z] Finished download-and-extract step (success) 11:06:24 INFO - [mozharness: 2016-12-02 19:06:24.769097Z] Running populate-webroot step. 11:06:24 INFO - Running pre-action listener: _resource_record_pre_action 11:06:24 INFO - Running main action method: populate_webroot 11:06:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:24 INFO - '--tppagecycles', 11:06:24 INFO - '7'], 11:06:24 INFO - 'tests': ['tsvgm']}}, 11:06:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['damp', 'tps']}, 11:06:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'tests': ['damp', 'tps']}, 11:06:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['dromaeo_dom']}, 11:06:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['basic_compositor_video']}, 11:06:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['a11yr', 11:06:24 INFO - 'ts_paint', 11:06:24 INFO - 'tpaint', 11:06:24 INFO - 'sessionrestore', 11:06:24 INFO - 'sessionrestore_no_auto_restore', 11:06:24 INFO - 'tabpaint']}, 11:06:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['tsvgx', 11:06:24 INFO - 'tsvgr_opacity', 11:06:24 INFO - 'tart', 11:06:24 INFO - 'tscrollx', 11:06:24 INFO - 'cart']}, 11:06:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:24 INFO - 'tsvgr_opacity', 11:06:24 INFO - 'tart', 11:06:24 INFO - 'tscrollx', 11:06:24 INFO - 'cart']}, 11:06:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'talos_options': ['--disable-e10s'], 11:06:24 INFO - 'tests': ['tp5o']}, 11:06:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'tests': ['tp5o']}, 11:06:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'talos_options': ['--disable-e10s', 11:06:24 INFO - '--xperf_path', 11:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:24 INFO - 'tests': ['tp5n']}, 11:06:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:24 INFO - 'talos_options': ['--xperf_path', 11:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:24 INFO - 'tests': ['tp5n']}}, 11:06:24 INFO - 'talos.zip': {'path': '', 11:06:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:24 INFO - Running post-action listener: _resource_record_post_action 11:06:24 INFO - [mozharness: 2016-12-02 19:06:24.788186Z] Finished populate-webroot step (success) 11:06:24 INFO - [mozharness: 2016-12-02 19:06:24.788280Z] Running create-virtualenv step. 11:06:24 INFO - Running pre-action listener: _resource_record_pre_action 11:06:24 INFO - Running main action method: create_virtualenv 11:06:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:24 INFO - Using real prefix '/usr' 11:06:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:27 INFO - Installing pip.................done. 11:06:27 INFO - Return code: 0 11:06:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:27 INFO - Using env: {'DISPLAY': ':0', 11:06:27 INFO - 'HOME': '/home/cltbld', 11:06:27 INFO - 'LANG': 'en_US.UTF-8', 11:06:27 INFO - 'LANGUAGE': 'en_US:en', 11:06:27 INFO - 'LOGNAME': 'cltbld', 11:06:27 INFO - 'MAIL': '/var/mail/cltbld', 11:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:27 INFO - 'MOZ_NO_REMOTE': '1', 11:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:27 INFO - 'NO_EM_RESTART': '1', 11:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:27 INFO - 'PWD': '/builds/slave/test', 11:06:27 INFO - 'SHELL': '/bin/bash', 11:06:27 INFO - 'SHLVL': '1', 11:06:27 INFO - 'TERM': 'linux', 11:06:27 INFO - 'TMOUT': '86400', 11:06:27 INFO - 'USER': 'cltbld', 11:06:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:27 INFO - '_': '/tools/buildbot/bin/python'} 11:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:06:27 INFO - Cleaning up... 11:06:27 INFO - Return code: 0 11:06:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:27 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:06:27 INFO - Using env: {'DISPLAY': ':0', 11:06:27 INFO - 'HOME': '/home/cltbld', 11:06:27 INFO - 'LANG': 'en_US.UTF-8', 11:06:27 INFO - 'LANGUAGE': 'en_US:en', 11:06:27 INFO - 'LOGNAME': 'cltbld', 11:06:27 INFO - 'MAIL': '/var/mail/cltbld', 11:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:27 INFO - 'MOZ_NO_REMOTE': '1', 11:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:27 INFO - 'NO_EM_RESTART': '1', 11:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:27 INFO - 'PWD': '/builds/slave/test', 11:06:27 INFO - 'SHELL': '/bin/bash', 11:06:27 INFO - 'SHLVL': '1', 11:06:27 INFO - 'TERM': 'linux', 11:06:27 INFO - 'TMOUT': '86400', 11:06:27 INFO - 'USER': 'cltbld', 11:06:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:27 INFO - '_': '/tools/buildbot/bin/python'} 11:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:27 INFO - Downloading/unpacking psutil>=3.1.1 11:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:29 INFO - Installing collected packages: psutil 11:06:29 INFO - Running setup.py install for psutil 11:06:29 INFO - building 'psutil._psutil_linux' extension 11:06:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:06:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:06:30 INFO - building 'psutil._psutil_posix' extension 11:06:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:06:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:30 INFO - Successfully installed psutil 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:30 INFO - Using env: {'DISPLAY': ':0', 11:06:30 INFO - 'HOME': '/home/cltbld', 11:06:30 INFO - 'LANG': 'en_US.UTF-8', 11:06:30 INFO - 'LANGUAGE': 'en_US:en', 11:06:30 INFO - 'LOGNAME': 'cltbld', 11:06:30 INFO - 'MAIL': '/var/mail/cltbld', 11:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:30 INFO - 'MOZ_NO_REMOTE': '1', 11:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:30 INFO - 'NO_EM_RESTART': '1', 11:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:30 INFO - 'PWD': '/builds/slave/test', 11:06:30 INFO - 'SHELL': '/bin/bash', 11:06:30 INFO - 'SHLVL': '1', 11:06:30 INFO - 'TERM': 'linux', 11:06:30 INFO - 'TMOUT': '86400', 11:06:30 INFO - 'USER': 'cltbld', 11:06:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:30 INFO - '_': '/tools/buildbot/bin/python'} 11:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:32 INFO - Installing collected packages: mozsystemmonitor 11:06:32 INFO - Running setup.py install for mozsystemmonitor 11:06:32 INFO - Successfully installed mozsystemmonitor 11:06:32 INFO - Cleaning up... 11:06:32 INFO - Return code: 0 11:06:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:32 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:06:32 INFO - Using env: {'DISPLAY': ':0', 11:06:32 INFO - 'HOME': '/home/cltbld', 11:06:32 INFO - 'LANG': 'en_US.UTF-8', 11:06:32 INFO - 'LANGUAGE': 'en_US:en', 11:06:32 INFO - 'LOGNAME': 'cltbld', 11:06:32 INFO - 'MAIL': '/var/mail/cltbld', 11:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:32 INFO - 'MOZ_NO_REMOTE': '1', 11:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:32 INFO - 'NO_EM_RESTART': '1', 11:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:32 INFO - 'PWD': '/builds/slave/test', 11:06:32 INFO - 'SHELL': '/bin/bash', 11:06:32 INFO - 'SHLVL': '1', 11:06:32 INFO - 'TERM': 'linux', 11:06:32 INFO - 'TMOUT': '86400', 11:06:32 INFO - 'USER': 'cltbld', 11:06:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:32 INFO - '_': '/tools/buildbot/bin/python'} 11:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:33 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:35 INFO - warning: no files found matching '*.txt' 11:06:35 INFO - no previously-included directories found matching 'build' 11:06:35 INFO - no previously-included directories found matching 'dist' 11:06:35 INFO - no previously-included directories found matching '.git*' 11:06:35 INFO - Installing collected packages: jsonschema, functools32 11:06:35 INFO - Running setup.py install for functools32 11:06:35 INFO - warning: no files found matching '*.txt' 11:06:35 INFO - no previously-included directories found matching 'build' 11:06:35 INFO - no previously-included directories found matching 'dist' 11:06:35 INFO - no previously-included directories found matching '.git*' 11:06:35 INFO - Successfully installed jsonschema functools32 11:06:35 INFO - Cleaning up... 11:06:35 INFO - Return code: 0 11:06:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:35 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:35 INFO - Using env: {'DISPLAY': ':0', 11:06:35 INFO - 'HOME': '/home/cltbld', 11:06:35 INFO - 'LANG': 'en_US.UTF-8', 11:06:35 INFO - 'LANGUAGE': 'en_US:en', 11:06:35 INFO - 'LOGNAME': 'cltbld', 11:06:35 INFO - 'MAIL': '/var/mail/cltbld', 11:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:35 INFO - 'MOZ_NO_REMOTE': '1', 11:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:35 INFO - 'NO_EM_RESTART': '1', 11:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:35 INFO - 'PWD': '/builds/slave/test', 11:06:35 INFO - 'SHELL': '/bin/bash', 11:06:35 INFO - 'SHLVL': '1', 11:06:35 INFO - 'TERM': 'linux', 11:06:35 INFO - 'TMOUT': '86400', 11:06:35 INFO - 'USER': 'cltbld', 11:06:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:35 INFO - '_': '/tools/buildbot/bin/python'} 11:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:35 INFO - Cleaning up... 11:06:35 INFO - Return code: 0 11:06:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:35 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:35 INFO - Using env: {'DISPLAY': ':0', 11:06:35 INFO - 'HOME': '/home/cltbld', 11:06:35 INFO - 'LANG': 'en_US.UTF-8', 11:06:35 INFO - 'LANGUAGE': 'en_US:en', 11:06:35 INFO - 'LOGNAME': 'cltbld', 11:06:35 INFO - 'MAIL': '/var/mail/cltbld', 11:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:35 INFO - 'MOZ_NO_REMOTE': '1', 11:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:35 INFO - 'NO_EM_RESTART': '1', 11:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:35 INFO - 'PWD': '/builds/slave/test', 11:06:35 INFO - 'SHELL': '/bin/bash', 11:06:35 INFO - 'SHLVL': '1', 11:06:35 INFO - 'TERM': 'linux', 11:06:35 INFO - 'TMOUT': '86400', 11:06:35 INFO - 'USER': 'cltbld', 11:06:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:35 INFO - '_': '/tools/buildbot/bin/python'} 11:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:36 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:38 INFO - Downloading docopt-0.6.1.tar.gz 11:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:38 INFO - Running setup.py install for blobuploader 11:06:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:38 INFO - Running setup.py install for requests 11:06:39 INFO - Running setup.py install for docopt 11:06:39 INFO - Successfully installed blobuploader requests docopt 11:06:39 INFO - Cleaning up... 11:06:39 INFO - Return code: 0 11:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:39 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:39 INFO - Using env: {'DISPLAY': ':0', 11:06:39 INFO - 'HOME': '/home/cltbld', 11:06:39 INFO - 'LANG': 'en_US.UTF-8', 11:06:39 INFO - 'LANGUAGE': 'en_US:en', 11:06:39 INFO - 'LOGNAME': 'cltbld', 11:06:39 INFO - 'MAIL': '/var/mail/cltbld', 11:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:39 INFO - 'MOZ_NO_REMOTE': '1', 11:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:39 INFO - 'NO_EM_RESTART': '1', 11:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:39 INFO - 'PWD': '/builds/slave/test', 11:06:39 INFO - 'SHELL': '/bin/bash', 11:06:39 INFO - 'SHLVL': '1', 11:06:39 INFO - 'TERM': 'linux', 11:06:39 INFO - 'TMOUT': '86400', 11:06:39 INFO - 'USER': 'cltbld', 11:06:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:39 INFO - '_': '/tools/buildbot/bin/python'} 11:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:39 INFO - Running setup.py (path:/tmp/pip-eTfNcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:39 INFO - Running setup.py (path:/tmp/pip-XR8_A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:39 INFO - Running setup.py (path:/tmp/pip-J_PK5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:39 INFO - Running setup.py (path:/tmp/pip-N6PuXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:39 INFO - Running setup.py (path:/tmp/pip-p7EaD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:39 INFO - Running setup.py (path:/tmp/pip-QLPezQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:40 INFO - Running setup.py (path:/tmp/pip-OokCHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:40 INFO - Running setup.py (path:/tmp/pip-mfwwOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:40 INFO - Running setup.py (path:/tmp/pip-r6rNwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:40 INFO - Running setup.py (path:/tmp/pip-jRSX4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:40 INFO - Running setup.py (path:/tmp/pip-oXnpOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:40 INFO - Running setup.py (path:/tmp/pip-4gnril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:40 INFO - Running setup.py (path:/tmp/pip-Q5gFct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:40 INFO - Running setup.py (path:/tmp/pip-554UPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:40 INFO - Running setup.py (path:/tmp/pip-1zevAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:40 INFO - Running setup.py (path:/tmp/pip-3yfjp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:40 INFO - Running setup.py (path:/tmp/pip-NM3I7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:40 INFO - Running setup.py install for manifestparser 11:06:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:40 INFO - Running setup.py install for mozcrash 11:06:41 INFO - Running setup.py install for mozdebug 11:06:41 INFO - Running setup.py install for mozdevice 11:06:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for mozfile 11:06:41 INFO - Running setup.py install for mozhttpd 11:06:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for mozinfo 11:06:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for mozInstall 11:06:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for mozleak 11:06:41 INFO - Running setup.py install for mozlog 11:06:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for moznetwork 11:06:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:41 INFO - Running setup.py install for mozprocess 11:06:42 INFO - Running setup.py install for mozprofile 11:06:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:42 INFO - Running setup.py install for mozrunner 11:06:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:42 INFO - Running setup.py install for mozscreenshot 11:06:42 INFO - Running setup.py install for moztest 11:06:42 INFO - Running setup.py install for mozversion 11:06:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:42 INFO - Cleaning up... 11:06:42 INFO - Return code: 0 11:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:42 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:42 INFO - Using env: {'DISPLAY': ':0', 11:06:42 INFO - 'HOME': '/home/cltbld', 11:06:42 INFO - 'LANG': 'en_US.UTF-8', 11:06:42 INFO - 'LANGUAGE': 'en_US:en', 11:06:42 INFO - 'LOGNAME': 'cltbld', 11:06:42 INFO - 'MAIL': '/var/mail/cltbld', 11:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:42 INFO - 'MOZ_NO_REMOTE': '1', 11:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:42 INFO - 'NO_EM_RESTART': '1', 11:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:42 INFO - 'PWD': '/builds/slave/test', 11:06:42 INFO - 'SHELL': '/bin/bash', 11:06:42 INFO - 'SHLVL': '1', 11:06:42 INFO - 'TERM': 'linux', 11:06:42 INFO - 'TMOUT': '86400', 11:06:42 INFO - 'USER': 'cltbld', 11:06:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:42 INFO - '_': '/tools/buildbot/bin/python'} 11:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:42 INFO - Running setup.py (path:/tmp/pip-htZwTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:42 INFO - Running setup.py (path:/tmp/pip-dXru6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:43 INFO - Running setup.py (path:/tmp/pip-AJ2_d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:43 INFO - Running setup.py (path:/tmp/pip-cp34QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:43 INFO - Running setup.py (path:/tmp/pip-5xJATI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:43 INFO - Running setup.py (path:/tmp/pip-fMApN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:43 INFO - Running setup.py (path:/tmp/pip-xrwJJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:43 INFO - Running setup.py (path:/tmp/pip-empSoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:43 INFO - Running setup.py (path:/tmp/pip-NvhQ48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:43 INFO - Running setup.py (path:/tmp/pip-w8wZZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:43 INFO - Running setup.py (path:/tmp/pip-Pya6pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:43 INFO - Running setup.py (path:/tmp/pip-8mzZ9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:43 INFO - Running setup.py (path:/tmp/pip-z61d2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:43 INFO - Running setup.py (path:/tmp/pip-hhwhYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:43 INFO - Running setup.py (path:/tmp/pip-3J_OLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:43 INFO - Running setup.py (path:/tmp/pip-PASEtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:44 INFO - Running setup.py (path:/tmp/pip-40d7gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:46 INFO - Downloading blessings-1.6.tar.gz 11:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:46 INFO - Installing collected packages: blessings 11:06:46 INFO - Running setup.py install for blessings 11:06:46 INFO - Successfully installed blessings 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:46 INFO - Reading from file tmpfile_stdout 11:06:46 INFO - Current package versions: 11:06:46 INFO - argparse == 1.2.1 11:06:46 INFO - blessings == 1.6 11:06:46 INFO - blobuploader == 1.2.4 11:06:46 INFO - docopt == 0.6.1 11:06:46 INFO - functools32 == 3.2.3-2 11:06:46 INFO - jsonschema == 2.5.1 11:06:46 INFO - manifestparser == 1.1 11:06:46 INFO - mozInstall == 1.12 11:06:46 INFO - mozcrash == 0.17 11:06:46 INFO - mozdebug == 0.1 11:06:46 INFO - mozdevice == 0.48 11:06:46 INFO - mozfile == 1.2 11:06:46 INFO - mozhttpd == 0.7 11:06:46 INFO - mozinfo == 0.9 11:06:46 INFO - mozleak == 0.1 11:06:46 INFO - mozlog == 3.4 11:06:46 INFO - moznetwork == 0.27 11:06:46 INFO - mozprocess == 0.23 11:06:46 INFO - mozprofile == 0.28 11:06:46 INFO - mozrunner == 6.12 11:06:46 INFO - mozscreenshot == 0.1 11:06:46 INFO - mozsystemmonitor == 0.3 11:06:46 INFO - moztest == 0.7 11:06:46 INFO - mozversion == 1.4 11:06:46 INFO - psutil == 3.1.1 11:06:46 INFO - requests == 1.2.3 11:06:46 INFO - wsgiref == 0.1.2 11:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:46 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:46 INFO - Using env: {'DISPLAY': ':0', 11:06:46 INFO - 'HOME': '/home/cltbld', 11:06:46 INFO - 'LANG': 'en_US.UTF-8', 11:06:46 INFO - 'LANGUAGE': 'en_US:en', 11:06:46 INFO - 'LOGNAME': 'cltbld', 11:06:46 INFO - 'MAIL': '/var/mail/cltbld', 11:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:46 INFO - 'MOZ_NO_REMOTE': '1', 11:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:46 INFO - 'NO_EM_RESTART': '1', 11:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:46 INFO - 'PWD': '/builds/slave/test', 11:06:46 INFO - 'SHELL': '/bin/bash', 11:06:46 INFO - 'SHLVL': '1', 11:06:46 INFO - 'TERM': 'linux', 11:06:46 INFO - 'TMOUT': '86400', 11:06:46 INFO - 'USER': 'cltbld', 11:06:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:46 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:46 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 0x7f8cd8397f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:46 INFO - Using env: {'DISPLAY': ':0', 11:06:46 INFO - 'HOME': '/home/cltbld', 11:06:46 INFO - 'LANG': 'en_US.UTF-8', 11:06:46 INFO - 'LANGUAGE': 'en_US:en', 11:06:46 INFO - 'LOGNAME': 'cltbld', 11:06:46 INFO - 'MAIL': '/var/mail/cltbld', 11:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:46 INFO - 'MOZ_NO_REMOTE': '1', 11:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:46 INFO - 'NO_EM_RESTART': '1', 11:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:46 INFO - 'PWD': '/builds/slave/test', 11:06:46 INFO - 'SHELL': '/bin/bash', 11:06:46 INFO - 'SHLVL': '1', 11:06:46 INFO - 'TERM': 'linux', 11:06:46 INFO - 'TMOUT': '86400', 11:06:46 INFO - 'USER': 'cltbld', 11:06:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:46 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Running post-action listener: _resource_record_post_action 11:06:46 INFO - Running post-action listener: _start_resource_monitoring 11:06:47 INFO - Starting resource monitoring. 11:06:47 INFO - [mozharness: 2016-12-02 19:06:47.017516Z] Finished create-virtualenv step (success) 11:06:47 INFO - [mozharness: 2016-12-02 19:06:47.017973Z] Running install step. 11:06:47 INFO - Running pre-action listener: _resource_record_pre_action 11:06:47 INFO - Running main action method: install 11:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:47 INFO - Reading from file tmpfile_stdout 11:06:47 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:47 INFO - Reading from file tmpfile_stdout 11:06:47 INFO - Output received: 11:06:47 INFO - Usage: mozinstall [options] installer 11:06:47 INFO - Options: 11:06:47 INFO - -h, --help show this help message and exit 11:06:47 INFO - -d DEST, --destination=DEST 11:06:47 INFO - Directory to install application into. [default: 11:06:47 INFO - "/builds/slave/test"] 11:06:47 INFO - --app=APP Application being installed. [default: firefox] 11:06:47 INFO - mkdir: /builds/slave/test/build/application 11:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:07:00 INFO - Reading from file tmpfile_stdout 11:07:00 INFO - Output received: 11:07:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:00 INFO - Running post-action listener: _resource_record_post_action 11:07:00 INFO - [mozharness: 2016-12-02 19:07:00.817269Z] Finished install step (success) 11:07:00 INFO - [mozharness: 2016-12-02 19:07:00.817513Z] Running run-tests step. 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: run_tests 11:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:00 INFO - Python 2.7.3 11:07:00 INFO - Return code: 0 11:07:00 INFO - grabbing minidump binary from tooltool 11:07: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')]} 11:07:00 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 0x20edf60>, '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 0x20eed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ef1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:07:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:07:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:07:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:00 INFO - Return code: 0 11:07:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:07:00 INFO - Using env: {'DISPLAY': ':0', 11:07:00 INFO - 'HOME': '/home/cltbld', 11:07:00 INFO - 'LANG': 'en_US.UTF-8', 11:07:00 INFO - 'LANGUAGE': 'en_US:en', 11:07:00 INFO - 'LOGNAME': 'cltbld', 11:07:00 INFO - 'MAIL': '/var/mail/cltbld', 11:07:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:00 INFO - 'MOZ_NO_REMOTE': '1', 11:07:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:00 INFO - 'NO_EM_RESTART': '1', 11:07:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:00 INFO - 'PWD': '/builds/slave/test', 11:07:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:00 INFO - 'SHELL': '/bin/bash', 11:07:00 INFO - 'SHLVL': '1', 11:07:00 INFO - 'TERM': 'linux', 11:07:00 INFO - 'TMOUT': '86400', 11:07:00 INFO - 'USER': 'cltbld', 11:07:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971', 11:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:00 INFO - '_': '/tools/buildbot/bin/python'} 11:07:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:07:01 INFO - mozversion application_buildid: 20161202090743 11:07:01 INFO - mozversion application_changeset: c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 11:07:01 INFO - mozversion application_display_name: Firefox 11:07:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:01 INFO - mozversion application_name: Firefox 11:07:01 INFO - mozversion application_remotingname: firefox 11:07:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:07:01 INFO - mozversion application_vendor: Mozilla 11:07:01 INFO - mozversion application_version: 51.0 11:07:01 INFO - mozversion platform_buildid: 20161202090743 11:07:01 INFO - mozversion platform_changeset: c491aa9d45371e2d0122a4a8ffbc5a250a8bb855 11:07:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:07:01 INFO - mozversion platform_version: 51.0 11:07:01 INFO - using testdate: 1480705621 11:07:01 INFO - actual date: 1480705621 11:07:01 INFO - starting webserver on 'localhost:53112' 11:07:01 INFO - SUITE-START | Running 2 tests 11:07:01 INFO - TEST-START | dromaeo_css 11:07:01 INFO - operating with platform_type : linux_ 11:07:01 INFO - Initialising browser for dromaeo_css test... 11:07:01 INFO - TEST-INFO | started process 3399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHu9UNP/profile http://localhost:53112/getInfo.html) 11:07:04 INFO - PROCESS | 3399 | __metrics Screen width/height:1600/1200 11:07:04 INFO - PROCESS | 3399 | colorDepth:24 11:07:04 INFO - PROCESS | 3399 | Browser inner width/height: 1024/697 11:07:04 INFO - PROCESS | 3399 | __metrics 11:07:05 INFO - PROCESS | 3399 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:07:05 INFO - PROCESS | 3399 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:06 INFO - PROCESS | 3399 | console.error: PushService: 11:07:06 INFO - PROCESS | 3399 | stateChangeProcessEnqueue: Error transitioning state 11:07:06 INFO - PROCESS | 3399 | UnknownError 11:07:06 INFO - TEST-INFO | 3399: exit 0 11:07:06 INFO - Browser initialized. 11:07:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:06 INFO - TEST-INFO | started process 3494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHu9UNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:18 INFO - PROCESS | 3494 | RSS: Main: 143265792 11:07:18 INFO - PROCESS | 3494 | 11:08:09 INFO - PROCESS | 3494 | 1480705689618 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:10:18 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53112/tests/dromaeo/cssquery-ext.html) 11:10:19 INFO - PROCESS | 3494 | RSS: Main: 220585984 11:10:19 INFO - PROCESS | 3494 | 11:13:22 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-ext.html (next: http://localhost:53112/tests/dromaeo/cssquery-jquery.html) 11:13:22 INFO - PROCESS | 3494 | RSS: Main: 228720640 11:13:22 INFO - PROCESS | 3494 | 11:16:24 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53112/tests/dromaeo/cssquery-mootools.html) 11:16:24 INFO - PROCESS | 3494 | RSS: Main: 224014336 11:16:24 INFO - PROCESS | 3494 | 11:19:26 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53112/tests/dromaeo/cssquery-prototype.html) 11:19:27 INFO - PROCESS | 3494 | RSS: Main: 174665728 11:19:27 INFO - PROCESS | 3494 | 11:22:29 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53112/tests/dromaeo/cssquery-yui.html) 11:22:30 INFO - PROCESS | 3494 | RSS: Main: 180862976 11:22:30 INFO - PROCESS | 3494 | 11:25:32 INFO - PROCESS | 3494 | Cycle 1(1): loaded http://localhost:53112/tests/dromaeo/cssquery-yui.html (next: http://localhost:53112/tests/dromaeo/cssquery-dojo.html) 11:25:33 INFO - PROCESS | 3494 | RSS: Main: 259518464 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | __start_tp_report 11:25:33 INFO - PROCESS | 3494 | _x_x_mozilla_page_load 11:25:33 INFO - PROCESS | 3494 | _x_x_mozilla_page_load_details 11:25:33 INFO - PROCESS | 3494 | |i|pagename|runs| 11:25:33 INFO - PROCESS | 3494 | |0;dojo.html;3097.7521798256143;3130.7495400367966;3155.226969392499;3170.0172946386638;3187.091678871522;5473.06957817171;5570.387257401692;5581.330240371156;5588.469095435927;5603.9999999999945;5672.290963629546;5754.309482862062;5754.482096611315;5757.539396848252;5760.45275698809;5160.801439759908;5223.320968274138;5230.7646155922885;5242.2136679498;5272.92090618641;4923.507649235065;5306.09796334624;5313.1233346497975;5315.123004704219;5341.412444631087;4924.4583095859425;5028.220625802988;5081.1108056090225;5115.872103197413;5176.404713457944;5165.457626949154;5180.766865491043;5260.500252476008;5265;5284;4847.903041939141;5095.439501654852;5166.457521960216;5220.321358223445;5241.659292145999;5325.440828712968;5343.545798607084;5466.671999680032;5479.589030822664;5491.039068163095;5895.705214739289;5908.734106965197;6034.637921724667;6041.637501749865;6045.093236014633;5860.208871802337;6046.818595442144;6060.636361818305;6072.210612620375;6077.513798896078;5516.365617953947;5640.210370548127;5691.573132015115;5702.7718891243885;5750.108733146369;6281.654509001957;6303.149074874833;6316.778912738032;6323.051542268605;6323.146375239376;5544.22380866679;6055.636661800306;6057.212562366864;6059.969700151471;6063.484603808725;5644.8871022579315;5670.489655930986;5736.827895163152;5741.598088133874;5742.31092268922;5691.9146212806845;5700.030994730822;5876.9118463223085;5916.970415147896;5935.7625694972585;5973.701314934236;6012.909806352908;6023.397660233942;6028.819135425944;6029.879402411927;4731.716097034189;4740.739259340769;4741.35991641124;4746.857594272177;4772.284157376352;3932.646061854447;3950.822213000422;4047.3321901886447;4068.9186216275507;4187.560306167808;5735.283089613798;5738.913916291259;5739.426057394227;5741.282339707536;5772.624779389326;5973.701314934236;6017.458428741435;6019.548533859978;6019.638821670626;6024.578279520391;5451.264079349237;5491.039068163055;5669.659820410789;5736.368999410061;5738.512226460714;5274.709890955957;5338.8932221356135;5339.839804805862;5360.571154307724;5378.327709036371;6342.429181373698;6343.841403964938;6344.175257216532;6348.269948955929;6352.364763523703;5648.4633959773755;5715.8571035724435;6175;6193.81418557444;6195.628262304096;6060.030395136757;6061.36355682647;6092.421219984094;6277.591956522811;6282.089097080989;5913.201717768218;5918.082697181943;5971.552133590085;5975.701214939322;6019.458248757633;5634.605577609528;6047.606905551125;6053.092036194606;6053.878922421615;6055.848603784941;5589.944100559105;5882.470577648032;5910.70446477683;5929.9110513341475;6042.8791424170395;5957.940420595739;5958.553108516965;5963.761449541969;5964.433378829004;5966.880662386641;5927.525797936069;5927.9703601481715;5930.080837470199;5930.762769489172;5932.822015339547;5665.943340566707;5667.036603777286;5833.854153646023;5887.764489420375;5901.940980590311;5796.246487956539;5820.156077368673;5826.970865145647;5831.650100993954;5832.766689332379 11:25:33 INFO - PROCESS | 3494 | |1;ext.html;578.3637998201979;590.982270531884;637.7225906730571;662.1855118204611;667.9899801502976;33889.83055084724;34507.137321566974;45925.77037114814;46886.76556617221;46964;44433.555664443345;48392.75803620986;48499.51500484994;48559.02881942368;48592.51407485924;8325.791855203608;9196;9336.81326373472;9348.906510934905;9354.485503297316;8217.465864718804;10880.836787448156;11073.280236784623;11108;11442.828357574643;11290.548378064868;11342.035926946219;11355.205135640508;11365.431728413587;11367.602133925315;10603.469826508644;10662.093722033636;10675.733106672356;10684.198685098649;10684.679459616224;10950.06924411418;11010;11023.283486573348;11037.227394082418;11044.502997365058;44100.55899440996;44228.557714422765;44324.11351772946;44425;44443.555564444265;3472.8958131256104;3560.483729859182;3560.9821950890077;3617.457381392786;3744.9812750936344;32801.6719832801;32810.835945820116;33018;33497.497537536954;33590.32819343624;4576.290674945389;4638.350630911675;4665.603423708989;4685.2972054191805;4753.263244197155;367719;367941;368024;369272;369554;60637.180884573536;60926.086108708405;60938.47653808602;60940.695296523234;61022;40120.79939600283;40352.79823600922;40750.592494075274;43075.56924430715;43110.56889431066;19536.12087456068;19751.506212344808;19778;19778.802211977985;19779.802201977796;12300.261984280973;12524.81212781809;14385.928070359581;15129.167895765839;15244.923775381052;19579.412617621496;19911;20024.69962950557;20153.899230503754;20163.294284699965;7292.234315396913;7397.223291554417;7452.329290363893;7507.399408047343;7518.436117291225;971.32007594684;1064.6486659402378;1131.4003578103618;1140.863096428434;1143.3482914738686;34177;34723.096444164716;34815.303693926486;34821.47767783485;35010.474842877375;1151.1711567671264;1197.8838707118475;1231.587418214908;1236.202649291202;1292.476546998467;17077;18151.727724083885;18320.358787442376;18388.26446942134;18654.16056277471;587750;593905;598606;599116;606176;61509.38490615126;62292.06561901575;62296.37703622996;62412.687936560025;62432.68783656143;1280.6094141286997;1321.973560528784;1372.3755691160698;1392.693607406369;1440.157507857894;33314.33371332511;34756.82621586876;35106;35392.64607353997;35709.64290357063;51885.22172167345;52788.736056319474;53003.46996529985;53025.469745302056;53040;408482;410286;410428;413620;417936;27012.864935675196;27467.587986180624;29829.70170298356;30295.394092118477;30601.387972239987;49488.25767613561;49545.25682114699;50144;50251.49748502468;50648.24027639515;42235.7888210557;42432.36351454793;42607.57392426036;42866.57133428626;44078.55921440745;41629.58370416378;41841.79079104585;41900.58099419089;43401.13197736091;43942.780286099645;43107.568924310355;43130;43555.782221088695;44029.119417610826;44203.33694994642;35628.287434250655;38228.42657360197;38417.80791096027;39036.80481597574;39443.21113577655;29334.85332573409;29495.26261843471;29659;29736.553951690308;29754 11:25:33 INFO - PROCESS | 3494 | |2;jquery.html;412.21267379305516;413.2190160596471;422.83509431321784;425.27702905061403;431.5360986939039;18892;19963.201471941124;20594.48513787156;20965.47586310343;21118.683219751714;20150.496237594067;20332.89833550834;20374.592508149828;20811.479713007146;20895.37313880586;5883.0881213411985;6128.233970753656;6142.600730952474;6149.938500615003;6151.477124444427;5928.55535834812;5961.225040744697;5986.790462333819;6008.519318454535;6078.966575682122;6012.398760123974;6012.669303188345;6013.669248191348;6013.72938217779;6018.15745795589;5766.625169363999;5883.88206240815;5923.911141332884;5931.199288096095;5986.5210783137245;5368.570514358881;5368.758405871745;5381.838544843661;5385.407605163429;5387.838364849061;23834.40413989647;24123.517529649485;24203.515929681485;24424.511509769705;24585.508289834102;2573.6525569048313;2580.780633646142;2618.384679600292;2621.659184306047;2659.6542449481635;13214.471421143142;14663.120212787268;15291.158986255752;15495.535133946;15724.29240684172;1962.4014675523958;2043.2133628552965;2063.329417939176;2067.8759274443582;2080.2303147835396;75922;79076;80223;81334.9999999994;83818.58090709569;10866;11169.273997190157;11227.270227435354;11299.887001130048;11578.536858525733;16391.5902102446;16406.67186656284;16427.09650969208;16431.589210269838;16435.09606971604;8739.91260087391;8819.250363719028;8892.644294228288;8921;9025.368224224372;8711.825763484694;8756.737297881074;8771.517566533774;8970.147835955573;8979.326550508738;6893.75871844493;7048.612326321999;7064.929350706427;7089.113860767404;7112.324329188718;1974.2596526302636;1989.3435166395054;1993.1031036033842;2015.4155294964296;2063.4928561797487;982.5185659027026;1024.3188279793853;1049.5277125293649;1062.4050531702271;1068.391017120234;20155.798442015686;20813.37559873176;20832.79167208339;20904.79095209059;21078.262260820797;1049.627382279295;1052.2108418685987;1052.3054783842626;1071.737424331044;1082.7130810335268;10646.840297395545;11960.40197990097;12035.699107522381;12048.75902481963;12156;537814;543332;543415;561105;568012;78253;79897.60051199707;81291;81575.59212203902;81721;1054.7732237568805;1059.0362769879373;1059.0944742245424;1093.830456279278;1100.8954149355798;18121;18353.81646183521;18624.16191271369;18873.622527549647;18997.14512846953;40344.798276008434;40564.1887162261;40852.79573602113;41341.793291033355;41650.58349416467;52976.20535691891;53635.46364536461;54250.72874635601;54358.45641543692;55005.449945501634;5909.113632955091;8026.678932842621;8476.49141051539;8563.186497282748;8772.473651580925;12316.815247771112;12420.875791241971;12683.746325073631;12812.423440944993;12840.55058072963;10923.781524369628;11002;11029.227954043461;11259.324440533594;11431.542738290374;10802.783944321227;10897.291676041032;10973.23187376876;10998.34009959405;11092.445377730919;11058.723531911766;11233.71915702114;11298.717532061435;11381.146414019147;11500.597479088192;7555.093388793161;8517.148285171434;8548.615312310836;8642.395032347675;8874.06822283651;5763.6541807491685;9940.353876997971;9988.750281243027;11412.71468213268;11622.418879056182 11:25:33 INFO - PROCESS | 3494 | |3;mootools.html;1317.9670508237298;1424.693690856466;1496.2518740629685;1581.7231984402727;1821.0712536606327;8074.636641351139;9301.581428835701;9541.188998935082;9573.473458959763;9859.507024648758;9505.667301644444;9574.329796914202;9585.2811039172;9592.232621390289;9599.664011759589;2517.2574090643257;2536.9492610147786;2541.3900663840636;2541.5806391945307;2542.3135753346587;2457.6436416719566;2545.4527276635517;2548.6686730724978;2556.1053631229015;2557.5268575313535;2462.285937078254;2468.3829042739317;2521.6091505816626;2522.230719630521;2523.570992931206;2453.3008092693676;2457.8402403843784;2468.222509909373;2500.462400583865;2502.6120951252583;2431.112643884987;2467.432490527171;2470.7158676752224;2475.71529274134;2497.325722055053;9354.158125768714;9463;9500.524973751284;9624.663136790248;9638.277129215337;5414.620976531644;5618.213450116987;5634.239377684001;5644.463775941279;5656.943430565683;3506.491558723996;3508.2281897982657;3549.343371476259;3579.6599323064265;3587.0494319005484;1212.9818052729215;1222.437678667805;1243.2975368916623;1259.4521383198246;1273.4842388832537;13887.722245555033;13946.302684865715;13959.092658977133;13993.30033498321;14005.229712365815;4762.52374762521;4768.737719425465;4812.903741925142;4927.384076990376;4952.529509696573;10771.730706732395;10781.245312828027;10782.4069676167;10783.083437907866;10792.730181745363;5567.944320556823;5591.021571225019;5591.888162236733;5593.720313984366;5602.85992850182;4398.3402489626815;4548.113117942035;4688.929666055012;4749.216379297446;5209.322788037531;4039.091204478969;4123.083272328815;4140.23405669952;4199.664026877843;4210.7473551587;1212.1272683667746;1229.397595178374;1230.7415442756942;1246.0903540415366;1248.1013670157472;899.7971240221981;982.4400091947664;1029.330934892311;1041.250299784154;1048.4024106259512;6454.386833250834;6572.868542629216;6608.2730899601;6663.666816659148;6794.252632210453;486.8028448478372;487.8390131256677;491.7369207473984;495.23733450486566;500.53700327197197;4336.046069864625;4378.6278166356215;4470.530594287618;4556.954430455653;4559.908801823945;11683.123765717604;11975.580854670045;12032.338221397908;12032.458539365749;12064.034877209802;11513.827292590619;11929.224600400947;11967.281963082243;11973.580924667594;11983.88016119845;8415.410921235454;8596.785080372916;8596.78508037304;8600.311975041981;8600.526971016654;6682.799516014527;6751.189857217166;6751.831204219738;6758.42553382968;6813.8977915330315;11049.613263535737;11241.831372529256;11281.32312061279;11307.547698091985;11418.257813242113;10164.949175254076;10499.580016799242;11597.18819682614;11648.941755291507;11650.825237621273;8076.676932922617;8146.959265203636;8266.751997440086;8358.623861926106;8603.440776349516;9168.220701240469;9590.328676992543;9594.088561586637;9596.76008099803;9607.951960240154;8378.287845532954;8445.95777021111;8508.106648801786;8509.574521273787;8570.48577085377;8352.123027082313;8383.161683831568;8424.663013479392;8429.367797415096;8578.227959483676;7774.805629859299;7783.922160778547;7798.961005194938;7835.451518393657;7911.762647120596;5721.456461636138;5762.740676669644;5774.595778295647;5860.267466566679;5960.344362120077;5737.827865164052;5821.854453638523;5867.413258674099;5871.559633027626;5939.910901336397 11:25:33 INFO - PROCESS | 3494 | |4;prototype.html;332.29553346904567;335.55874025656277;336.0556835292826;339.9004221343952;344.9948250776239;5586.832395028146;5616.5787565932515;5633.478960680613;5653.915191272124;5665.971670141648;5505.752241149148;5532.75102620382;5560.165975103737;5594.510442852922;5597.916031259524;4113.753174809521;4216.852410165645;4243.469566304212;4368.432103826498;4371.103923695635;4337.262665346882;4341.41390912226;4371.519132895379;4392.714473559208;4392.780360981954;4319.250703465102;4322.113966636847;4327.588879056485;4331.397382968306;4336.63138633215;4066.8169932352966;4303.246931786956;4312.870613881557;4314.201872653538;4364.170807546572;3793.3551296279697;3794.962050379516;3800.6959443244473;3802.4676545283683;3813.656770890633;5433.4566543345745;5450.945490545084;5453.727313634303;5479.780808767645;5485.61600687952;4817.927731084036;4845.885446347324;4877.414970065871;4917.606591472673;4953.356063711694;5686.857828554278;5702;5703.201551782754;5729.255196824428;5740.856478588027;4125.690573207022;4127.050778320973;4131.029208136086;4138.213739389536;4165.146145040259;5853.970730146365;5931.911021334683;5954.523638108941;6001.489128859623;6031.849203769897;4131.814068366931;4157.958420415817;4165.625093741578;4169.1661667666585;4195.517515485697;4226.372846454075;4246.554111818215;4274.871753847389;4280.892977675583;4290.163418133497;4669;4807.230843065093;4842.685225460334;4909.631777616693;4912.484189160158;5731.312242530923;5760.164776107441;5764.5676574257095;5767.682777447197;5773.70091729366;1432.9641758956109;1442.8773554247796;1452.1722618107788;1471.4996901053694;1476.0184477322675;899.0559912092277;911.4576826788051;942.0767647705151;951.6716732727198;972.3436680240809;5474.233607294902;5596.901162064226;5616.719164041781;5643.40744221859;5664.54683625309;5994.970025149846;6006.759729610854;6007.669578173155;6014.368491308437;6059.212302400748;5493.835184944458;5662.754194077296;5681.744321505542;5705.771769129271;5705.942940570624;3149.7165255127147;3158.368326334742;3166.699163579456;3173.4767311690516;3193.9361212775616;5875.384269325969;5998.340182579913;6072.939270607238;6085.6348619083;6147.754089836446;5948.839976204685;5998.220231369981;6040.848978775478;6047.3045599755715;6048.183495228176;6072.36240194782;6104.38956104386;6112.380219241904;6159.353267906805;6185.319614842454;5795.507381872588;5892.292924849045;5925.40745925404;5936.465718085393;5997.370276121119;5815.534757219328;5834.737436815269;5884.58807883444;5887.587868849139;5896.70516474166;5929.525637948867;6048.90926636092;6084.269887613515;6095.238095238095;6154.969225153845;4270.423492828429;4284.357346398066;4299.677524185636;4310.568943105664;4331.675124365748;5954.3152537458745;5981.2822461303185;6006.759729610767;6012.8797424052145;6023.30731965812;5617.382087970402;5773.3072031356505;5832.183494310715;5841.18223448709;5915.112733090071;5769;5770.2498675171955;5784.82645520635;5793.188953546591;5822.155787410887;5642.605017648725;5764.36591974874;5773.480386765212;5812.622179558484;5840.649561026352;5722.0272553665145;5809.970950145392;5814.680192589448;5816.749398879261;5837.211976383134;5687.431256874445;5689.829305120853;5690.374058853606;5696.401877802937;5745.597808153389 11:25:33 INFO - PROCESS | 3494 | |5;yui.html;660.2176420941186;676.6616691654173;696.7456878239443;705.2312978853049;747.8669815229928;14931.925340373296;16047.438339658114;16065.919670401661;16071.035737855707;16179.271932763024;14686.339114739836;14819.259037048132;14845.257737113128;14851.183184924852;14862.925685371558;705.3898377903129;723.3345322303494;738.4240292571802;829.6930135849744;853.9018012928531;850.090403268503;851.6040041380757;857.1086070486717;857.1428571428571;857.4598003257938;912.2792993535099;914.5290175559592;914.7850255190025;914.9771255718628;915.1306259053893;905.6784841381346;906.8775715278452;907.7866701325183;908.246155690775;908.5184852028402;671.392389887153;671.7413795688647;671.758167059858;672.1228796420669;672.3780503034674;14088.788668169986;14100.365483553265;14104.294785260696;14122.646933826634;14127.293635318296;15381.92309038459;15811.762823557656;15863.841361586352;15999.285214361262;16250.02499850001;13008.284544350057;13143.934280328633;13175.20948743069;13244.735105297936;13249.735005299937;4128.855490057834;4150.792460376969;4224.112936283384;4243.681723870691;4253.425787518676;68910.31089689139;70593.9410908842;86133.56933215357;88408;88764.55617721935;11894.226875253082;11915.285082895054;12073;12083.275003499819;12257.325847078497;22439.32682019542;22451.663225051638;22638.773612263994;23057.654135187986;23088.307350779167;8395.706150284834;8491.448055876348;8741.213290803858;9252.398594091363;9768.951155244178;4815.253635686474;4838.225883858566;4985.55130038291;5049.2173713074535;5049.2426136079885;3443.5523381960184;3572.4284114541547;3574.9285014299567;3577.177249232691;3577.266660334625;569.1718549510452;577.1314172170856;585.2917969257246;591.3879135095156;595.9970200148972;720.2545365546634;726.7311094894923;729.956202627844;730.2369024369547;745.5079647432668;9296.256299496024;9794.216462682969;10097.293189476813;10322.587096516205;10599.417032063157;504.3972452918727;554.6062295770048;618.8236352639476;618.8669436071176;623.9704487595503;4686.484486706459;4718.669693121448;4733.573978341966;4787.688800227974;4791.161546729309;128361.71638283685;131329;132227;134974.32512837372;140030;65083.67458162679;98429;118721.40639296749;119548.40225798989;120927;101443;103687.48156259171;106001;107070.46464767626;108124;9114.817703646022;9288.58201380953;9369.718908432758;9522.714318570454;9648.324617276723;60776.392236077074;61753.38246617656;62533;62652.373476264656;63359.6832015837;70049;70662;71144.64427677829;76586.6170669143;91840;12541.874581254071;12654.620361389174;12703.745925081632;12778.105532612628;13305.866941330463;14877.776833347292;15086.54740357791;15133.167675777497;15301;15410.152441615819;14388.20864852443;14497.20265385414;14611.561653150422;14717.55847324582;14958.775618365951;12874.291913944822;12964.157329773534;13105.606831795061;13210.471581136648;13402.865971340161;13233.470661173445;13344.399502022627;13918.721625567634;13919.512817051354;14402.783958240845;11775.941120294687;12030.578929737418;12226.510939562673;12253.69365765863;12517.371352015814;11276.830847537129;12155.939220304195;12414.62756117318;12674.746505069663;12758.553450629184 11:25:33 INFO - PROCESS | 3494 | __end_tp_report 11:25:33 INFO - PROCESS | 3494 | __start_cc_report 11:25:33 INFO - PROCESS | 3494 | _x_x_mozilla_cycle_collect,1043 11:25:33 INFO - PROCESS | 3494 | __end_cc_report 11:25:33 INFO - PROCESS | 3494 | __startTimestamp1480706733209__endTimestamp 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | ------- Summary: start ------- 11:25:33 INFO - PROCESS | 3494 | Number of tests: 6 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#0] dojo.html Cycles:165 Average:5591.42 Median:5742.31 stddev:643.73 (11.2%) stddev-sans-first:615.26 11:25:33 INFO - PROCESS | 3494 | Values: 3097.8 3130.7 3155.2 3170.0 3187.1 5473.1 5570.4 5581.3 5588.5 5604.0 5672.3 5754.3 5754.5 5757.5 5760.5 5160.8 5223.3 5230.8 5242.2 5272.9 4923.5 5306.1 5313.1 5315.1 5341.4 4924.5 5028.2 5081.1 5115.9 5176.4 5165.5 5180.8 5260.5 5265.0 5284.0 4847.9 5095.4 5166.5 5220.3 5241.7 5325.4 5343.5 5466.7 5479.6 5491.0 5895.7 5908.7 6034.6 6041.6 6045.1 5860.2 6046.8 6060.6 6072.2 6077.5 5516.4 5640.2 5691.6 5702.8 5750.1 6281.7 6303.1 6316.8 6323.1 6323.1 5544.2 6055.6 6057.2 6060.0 6063.5 5644.9 5670.5 5736.8 5741.6 5742.3 5691.9 5700.0 5876.9 5917.0 5935.8 5973.7 6012.9 6023.4 6028.8 6029.9 4731.7 4740.7 4741.4 4746.9 4772.3 3932.6 3950.8 4047.3 4068.9 4187.6 5735.3 5738.9 5739.4 5741.3 5772.6 5973.7 6017.5 6019.5 6019.6 6024.6 5451.3 5491.0 5669.7 5736.4 5738.5 5274.7 5338.9 5339.8 5360.6 5378.3 6342.4 6343.8 6344.2 6348.3 6352.4 5648.5 5715.9 6175.0 6193.8 6195.6 6060.0 6061.4 6092.4 6277.6 6282.1 5913.2 5918.1 5971.6 5975.7 6019.5 5634.6 6047.6 6053.1 6053.9 6055.8 5589.9 5882.5 5910.7 5929.9 6042.9 5957.9 5958.6 5963.8 5964.4 5966.9 5927.5 5928.0 5930.1 5930.8 5932.8 5665.9 5667.0 5833.9 5887.8 5901.9 5796.2 5820.2 5827.0 5831.7 5832.8 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#1] ext.html Cycles:180 Average:62544.65 Median:20986.70 stddev:124648.25 (593.9%) stddev-sans-first:124911.10 11:25:33 INFO - PROCESS | 3494 | Values: 578.4 591.0 637.7 662.2 668.0 33889.8 34507.1 45925.8 46886.8 46964.0 44433.6 48392.8 48499.5 48559.0 48592.5 8325.8 9196.0 9336.8 9348.9 9354.5 8217.5 10880.8 11073.3 11108.0 11442.8 11290.5 11342.0 11355.2 11365.4 11367.6 10603.5 10662.1 10675.7 10684.2 10684.7 10950.1 11010.0 11023.3 11037.2 11044.5 44100.6 44228.6 44324.1 44425.0 44443.6 3472.9 3560.5 3561.0 3617.5 3745.0 32801.7 32810.8 33018.0 33497.5 33590.3 4576.3 4638.4 4665.6 4685.3 4753.3 367719.0 367941.0 368024.0 369272.0 369554.0 60637.2 60926.1 60938.5 60940.7 61022.0 40120.8 40352.8 40750.6 43075.6 43110.6 19536.1 19751.5 19778.0 19778.8 19779.8 12300.3 12524.8 14385.9 15129.2 15244.9 19579.4 19911.0 20024.7 20153.9 20163.3 7292.2 7397.2 7452.3 7507.4 7518.4 971.3 1064.6 1131.4 1140.9 1143.3 34177.0 34723.1 34815.3 34821.5 35010.5 1151.2 1197.9 1231.6 1236.2 1292.5 17077.0 18151.7 18320.4 18388.3 18654.2 587750.0 593905.0 598606.0 599116.0 606176.0 61509.4 62292.1 62296.4 62412.7 62432.7 1280.6 1322.0 1372.4 1392.7 1440.2 33314.3 34756.8 35106.0 35392.6 35709.6 51885.2 52788.7 53003.5 53025.5 53040.0 408482.0 410286.0 410428.0 413620.0 417936.0 27012.9 27467.6 29829.7 30295.4 30601.4 49488.3 49545.3 50144.0 50251.5 50648.2 42235.8 42432.4 42607.6 42866.6 44078.6 41629.6 41841.8 41900.6 43401.1 43942.8 43107.6 43130.0 43555.8 44029.1 44203.3 35628.3 38228.4 38417.8 39036.8 39443.2 29334.9 29495.3 29659.0 29736.6 29754.0 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#2] jquery.html Cycles:180 Average:30598.79 Median:13579.58 stddev:90214.68 (664.3%) stddev-sans-first:90439.28 11:25:33 INFO - PROCESS | 3494 | Values: 412.2 413.2 422.8 425.3 431.5 18892.0 19963.2 20594.5 20965.5 21118.7 20150.5 20332.9 20374.6 20811.5 20895.4 5883.1 6128.2 6142.6 6149.9 6151.5 5928.6 5961.2 5986.8 6008.5 6079.0 6012.4 6012.7 6013.7 6013.7 6018.2 5766.6 5883.9 5923.9 5931.2 5986.5 5368.6 5368.8 5381.8 5385.4 5387.8 23834.4 24123.5 24203.5 24424.5 24585.5 2573.7 2580.8 2618.4 2621.7 2659.7 13214.5 14663.1 15291.2 15495.5 15724.3 1962.4 2043.2 2063.3 2067.9 2080.2 75922.0 79076.0 80223.0 81335.0 83818.6 10866.0 11169.3 11227.3 11299.9 11578.5 16391.6 16406.7 16427.1 16431.6 16435.1 8739.9 8819.3 8892.6 8921.0 9025.4 8711.8 8756.7 8771.5 8970.1 8979.3 6893.8 7048.6 7064.9 7089.1 7112.3 1974.3 1989.3 1993.1 2015.4 2063.5 982.5 1024.3 1049.5 1062.4 1068.4 20155.8 20813.4 20832.8 20904.8 21078.3 1049.6 1052.2 1052.3 1071.7 1082.7 10646.8 11960.4 12035.7 12048.8 12156.0 537814.0 543332.0 543415.0 561105.0 568012.0 78253.0 79897.6 81291.0 81575.6 81721.0 1054.8 1059.0 1059.1 1093.8 1100.9 18121.0 18353.8 18624.2 18873.6 18997.1 40344.8 40564.2 40852.8 41341.8 41650.6 52976.2 53635.5 54250.7 54358.5 55005.4 5909.1 8026.7 8476.5 8563.2 8772.5 12316.8 12420.9 12683.7 12812.4 12840.6 10923.8 11002.0 11029.2 11259.3 11431.5 10802.8 10897.3 10973.2 10998.3 11092.4 11058.7 11233.7 11298.7 11381.1 11500.6 7555.1 8517.1 8548.6 8642.4 8874.1 5763.7 9940.4 9988.8 11412.7 11622.4 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#3] mootools.html Cycles:180 Average:6287.28 Median:4719.07 stddev:3667.42 (77.7%) stddev-sans-first:3658.69 11:25:33 INFO - PROCESS | 3494 | Values: 1318.0 1424.7 1496.3 1581.7 1821.1 8074.6 9301.6 9541.2 9573.5 9859.5 9505.7 9574.3 9585.3 9592.2 9599.7 2517.3 2536.9 2541.4 2541.6 2542.3 2457.6 2545.5 2548.7 2556.1 2557.5 2462.3 2468.4 2521.6 2522.2 2523.6 2453.3 2457.8 2468.2 2500.5 2502.6 2431.1 2467.4 2470.7 2475.7 2497.3 9354.2 9463.0 9500.5 9624.7 9638.3 5414.6 5618.2 5634.2 5644.5 5656.9 3506.5 3508.2 3549.3 3579.7 3587.0 1213.0 1222.4 1243.3 1259.5 1273.5 13887.7 13946.3 13959.1 13993.3 14005.2 4762.5 4768.7 4812.9 4927.4 4952.5 10771.7 10781.2 10782.4 10783.1 10792.7 5567.9 5591.0 5591.9 5593.7 5602.9 4398.3 4548.1 4688.9 4749.2 5209.3 4039.1 4123.1 4140.2 4199.7 4210.7 1212.1 1229.4 1230.7 1246.1 1248.1 899.8 982.4 1029.3 1041.3 1048.4 6454.4 6572.9 6608.3 6663.7 6794.3 486.8 487.8 491.7 495.2 500.5 4336.0 4378.6 4470.5 4557.0 4559.9 11683.1 11975.6 12032.3 12032.5 12064.0 11513.8 11929.2 11967.3 11973.6 11983.9 8415.4 8596.8 8596.8 8600.3 8600.5 6682.8 6751.2 6751.8 6758.4 6813.9 11049.6 11241.8 11281.3 11307.5 11418.3 10164.9 10499.6 11597.2 11648.9 11650.8 8076.7 8147.0 8266.8 8358.6 8603.4 9168.2 9590.3 9594.1 9596.8 9608.0 8378.3 8446.0 8508.1 8509.6 8570.5 8352.1 8383.2 8424.7 8429.4 8578.2 7774.8 7783.9 7799.0 7835.5 7911.8 5721.5 5762.7 5774.6 5860.3 5960.3 5737.8 5821.9 5867.4 5871.6 5939.9 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#4] prototype.html Cycles:180 Average:4880.79 Median:5658.33 stddev:1441.81 (25.5%) stddev-sans-first:1404.86 11:25:33 INFO - PROCESS | 3494 | Values: 332.3 335.6 336.1 339.9 345.0 5586.8 5616.6 5633.5 5653.9 5666.0 5505.8 5532.8 5560.2 5594.5 5597.9 4113.8 4216.9 4243.5 4368.4 4371.1 4337.3 4341.4 4371.5 4392.7 4392.8 4319.3 4322.1 4327.6 4331.4 4336.6 4066.8 4303.2 4312.9 4314.2 4364.2 3793.4 3795.0 3800.7 3802.5 3813.7 5433.5 5450.9 5453.7 5479.8 5485.6 4817.9 4845.9 4877.4 4917.6 4953.4 5686.9 5702.0 5703.2 5729.3 5740.9 4125.7 4127.1 4131.0 4138.2 4165.1 5854.0 5931.9 5954.5 6001.5 6031.8 4131.8 4158.0 4165.6 4169.2 4195.5 4226.4 4246.6 4274.9 4280.9 4290.2 4669.0 4807.2 4842.7 4909.6 4912.5 5731.3 5760.2 5764.6 5767.7 5773.7 1433.0 1442.9 1452.2 1471.5 1476.0 899.1 911.5 942.1 951.7 972.3 5474.2 5596.9 5616.7 5643.4 5664.5 5995.0 6006.8 6007.7 6014.4 6059.2 5493.8 5662.8 5681.7 5705.8 5705.9 3149.7 3158.4 3166.7 3173.5 3193.9 5875.4 5998.3 6072.9 6085.6 6147.8 5948.8 5998.2 6040.8 6047.3 6048.2 6072.4 6104.4 6112.4 6159.4 6185.3 5795.5 5892.3 5925.4 5936.5 5997.4 5815.5 5834.7 5884.6 5887.6 5896.7 5929.5 6048.9 6084.3 6095.2 6155.0 4270.4 4284.4 4299.7 4310.6 4331.7 5954.3 5981.3 6006.8 6012.9 6023.3 5617.4 5773.3 5832.2 5841.2 5915.1 5769.0 5770.2 5784.8 5793.2 5822.2 5642.6 5764.4 5773.5 5812.6 5840.6 5722.0 5810.0 5814.7 5816.7 5837.2 5687.4 5689.8 5690.4 5696.4 5745.6 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - PROCESS | 3494 | [#5] yui.html Cycles:180 Average:22694.22 Median:3853.06 stddev:34009.84 (882.7%) stddev-sans-first:34065.01 11:25:33 INFO - PROCESS | 3494 | Values: 660.2 676.7 696.7 705.2 747.9 14931.9 16047.4 16065.9 16071.0 16179.3 14686.3 14819.3 14845.3 14851.2 14862.9 705.4 723.3 738.4 829.7 853.9 850.1 851.6 857.1 857.1 857.5 912.3 914.5 914.8 915.0 915.1 905.7 906.9 907.8 908.2 908.5 671.4 671.7 671.8 672.1 672.4 14088.8 14100.4 14104.3 14122.6 14127.3 15381.9 15811.8 15863.8 15999.3 16250.0 13008.3 13143.9 13175.2 13244.7 13249.7 4128.9 4150.8 4224.1 4243.7 4253.4 68910.3 70593.9 86133.6 88408.0 88764.6 11894.2 11915.3 12073.0 12083.3 12257.3 22439.3 22451.7 22638.8 23057.7 23088.3 8395.7 8491.4 8741.2 9252.4 9769.0 4815.3 4838.2 4985.6 5049.2 5049.2 3443.6 3572.4 3574.9 3577.2 3577.3 569.2 577.1 585.3 591.4 596.0 720.3 726.7 730.0 730.2 745.5 9296.3 9794.2 10097.3 10322.6 10599.4 504.4 554.6 618.8 618.9 624.0 4686.5 4718.7 4733.6 4787.7 4791.2 128361.7 131329.0 132227.0 134974.3 140030.0 65083.7 98429.0 118721.4 119548.4 120927.0 101443.0 103687.5 106001.0 107070.5 108124.0 9114.8 9288.6 9369.7 9522.7 9648.3 60776.4 61753.4 62533.0 62652.4 63359.7 70049.0 70662.0 71144.6 76586.6 91840.0 12541.9 12654.6 12703.7 12778.1 13305.9 14877.8 15086.5 15133.2 15301.0 15410.2 14388.2 14497.2 14611.6 14717.6 14958.8 12874.3 12964.2 13105.6 13210.5 13402.9 13233.5 13344.4 13918.7 13919.5 14402.8 11775.9 12030.6 12226.5 12253.7 12517.4 11276.8 12155.9 12414.6 12674.7 12758.6 11:25:33 INFO - PROCESS | 3494 | -------- Summary: end -------- 11:25:33 INFO - PROCESS | 3494 | 11:25:33 INFO - TEST-INFO | 3494: exit 0 11:25:33 INFO - TEST-OK | dromaeo_css | took 1112759ms 11:25:33 INFO - TEST-START | kraken 11:25:33 INFO - operating with platform_type : linux_ 11:25:33 INFO - Initialising browser for kraken test... 11:25:33 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp11roFn/profile http://localhost:53112/getInfo.html) 11:25:37 INFO - PROCESS | 3803 | __metrics Screen width/height:1600/1200 11:25:37 INFO - PROCESS | 3803 | colorDepth:24 11:25:37 INFO - PROCESS | 3803 | Browser inner width/height: 1024/697 11:25:37 INFO - PROCESS | 3803 | __metrics 11:25:38 INFO - PROCESS | 3803 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:38 INFO - PROCESS | 3803 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:38 INFO - PROCESS | 3803 | console.error: PushService: 11:25:38 INFO - PROCESS | 3803 | stateChangeProcessEnqueue: Error transitioning state 11:25:38 INFO - PROCESS | 3803 | UnknownError 11:25:39 INFO - TEST-INFO | 3803: exit 0 11:25:39 INFO - Browser initialized. 11:25:39 INFO - Running cycle 1/1 for kraken test... 11:25:39 INFO - TEST-INFO | started process 3896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp11roFn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:51 INFO - PROCESS | 3896 | RSS: Main: 143704064 11:25:51 INFO - PROCESS | 3896 | 11:25:53 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53112/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:54 INFO - PROCESS | 3896 | RSS: Main: 186785792 11:25:54 INFO - PROCESS | 3896 | 11:25:57 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53112/tests/kraken/driver.html?testName=audio-dft) 11:25:57 INFO - PROCESS | 3896 | RSS: Main: 173928448 11:25:57 INFO - PROCESS | 3896 | 11:26:00 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53112/tests/kraken/driver.html?testName=audio-fft) 11:26:01 INFO - PROCESS | 3896 | RSS: Main: 265834496 11:26:01 INFO - PROCESS | 3896 | 11:26:03 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53112/tests/kraken/driver.html?testName=audio-oscillator) 11:26:03 INFO - PROCESS | 3896 | RSS: Main: 171909120 11:26:03 INFO - PROCESS | 3896 | 11:26:05 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:06 INFO - PROCESS | 3896 | RSS: Main: 173854720 11:26:06 INFO - PROCESS | 3896 | 11:26:09 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53112/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:10 INFO - PROCESS | 3896 | RSS: Main: 209833984 11:26:10 INFO - PROCESS | 3896 | 11:26:13 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53112/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:13 INFO - PROCESS | 3896 | RSS: Main: 209010688 11:26:13 INFO - PROCESS | 3896 | 11:26:16 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53112/tests/kraken/driver.html?testName=json-parse-financial) 11:26:17 INFO - PROCESS | 3896 | RSS: Main: 208338944 11:26:17 INFO - PROCESS | 3896 | 11:26:18 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:19 INFO - PROCESS | 3896 | RSS: Main: 170463232 11:26:19 INFO - PROCESS | 3896 | 11:26:21 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:21 INFO - PROCESS | 3896 | RSS: Main: 177905664 11:26:21 INFO - PROCESS | 3896 | 11:26:23 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:24 INFO - PROCESS | 3896 | RSS: Main: 186929152 11:26:24 INFO - PROCESS | 3896 | 11:26:26 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:27 INFO - PROCESS | 3896 | RSS: Main: 196505600 11:26:27 INFO - PROCESS | 3896 | 11:26:30 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:30 INFO - PROCESS | 3896 | RSS: Main: 192458752 11:26:30 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | Cycle 1(1): loaded http://localhost:53112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53112/tests/kraken/driver.html?testName=ai-astar) 11:26:32 INFO - PROCESS | 3896 | RSS: Main: 244195328 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | __start_tp_report 11:26:32 INFO - PROCESS | 3896 | _x_x_mozilla_page_load 11:26:32 INFO - PROCESS | 3896 | _x_x_mozilla_page_load_details 11:26:32 INFO - PROCESS | 3896 | |i|pagename|runs| 11:26:32 INFO - PROCESS | 3896 | |0;ai-astar;113;111;111;111;111;112;112;111;110;109 11:26:32 INFO - PROCESS | 3896 | |1;audio-beat-detection;150;117;120;156;120;117;115;117;159;116 11:26:32 INFO - PROCESS | 3896 | |2;audio-dft;161;161;162;161;163;162;163;163;162;159 11:26:32 INFO - PROCESS | 3896 | |3;audio-fft;73;76;76;103;76;76;77;76;100;76 11:26:32 INFO - PROCESS | 3896 | |4;audio-oscillator;91;81;108;82;82;82;99;82;86;120 11:26:32 INFO - PROCESS | 3896 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 11:26:32 INFO - PROCESS | 3896 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;145;145 11:26:32 INFO - PROCESS | 3896 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;95 11:26:32 INFO - PROCESS | 3896 | |8;json-parse-financial;51;50;51;50;50;50;49;51;51;51 11:26:32 INFO - PROCESS | 3896 | |9;json-stringify-tinderbox;57;57;58;58;57;58;58;58;59;58 11:26:32 INFO - PROCESS | 3896 | |10;stanford-crypto-aes;73;74;74;78;76;79;74;74;73;74 11:26:32 INFO - PROCESS | 3896 | |11;stanford-crypto-ccm;123;132;125;126;130;121;120;119;154;129 11:26:32 INFO - PROCESS | 3896 | |12;stanford-crypto-pbkdf2;155;155;153;153;156;151;151;156;155;151 11:26:32 INFO - PROCESS | 3896 | |13;stanford-crypto-sha256-iterative;62;67;62;61;61;62;61;64;65;60 11:26:32 INFO - PROCESS | 3896 | __end_tp_report 11:26:32 INFO - PROCESS | 3896 | __start_cc_report 11:26:32 INFO - PROCESS | 3896 | _x_x_mozilla_cycle_collect,1585 11:26:32 INFO - PROCESS | 3896 | __end_cc_report 11:26:32 INFO - PROCESS | 3896 | __startTimestamp1480706792540__endTimestamp 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | ------- Summary: start ------- 11:26:32 INFO - PROCESS | 3896 | Number of tests: 14 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 11:26:32 INFO - PROCESS | 3896 | Values: 113.0 111.0 111.0 111.0 111.0 112.0 112.0 111.0 110.0 109.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:120.00 stddev:18.34 (15.3%) stddev-sans-first:17.76 11:26:32 INFO - PROCESS | 3896 | Values: 150.0 117.0 120.0 156.0 120.0 117.0 115.0 117.0 159.0 116.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 11:26:32 INFO - PROCESS | 3896 | Values: 161.0 161.0 162.0 161.0 163.0 162.0 163.0 163.0 162.0 159.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:10.93 (14.4%) stddev-sans-first:11.21 11:26:32 INFO - PROCESS | 3896 | Values: 73.0 76.0 76.0 103.0 76.0 76.0 77.0 76.0 100.0 76.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:13.51 (16.5%) stddev-sans-first:14.33 11:26:32 INFO - PROCESS | 3896 | Values: 91.0 81.0 108.0 82.0 82.0 82.0 99.0 82.0 86.0 120.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:26:32 INFO - PROCESS | 3896 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:26:32 INFO - PROCESS | 3896 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 145.0 145.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:26:32 INFO - PROCESS | 3896 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 11:26:32 INFO - PROCESS | 3896 | Values: 51.0 50.0 51.0 50.0 50.0 50.0 49.0 51.0 51.0 51.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 11:26:32 INFO - PROCESS | 3896 | Values: 57.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 59.0 58.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.08 (2.8%) stddev-sans-first:2.09 11:26:32 INFO - PROCESS | 3896 | Values: 73.0 74.0 74.0 78.0 76.0 79.0 74.0 74.0 73.0 74.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:127.50 stddev:10.16 (8.0%) stddev-sans-first:10.62 11:26:32 INFO - PROCESS | 3896 | Values: 123.0 132.0 125.0 126.0 130.0 121.0 120.0 119.0 154.0 129.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:155.00 stddev:2.07 (1.3%) stddev-sans-first:2.13 11:26:32 INFO - PROCESS | 3896 | Values: 155.0 155.0 153.0 153.0 156.0 151.0 151.0 156.0 155.0 151.0 11:26:32 INFO - PROCESS | 3896 | 11:26:32 INFO - PROCESS | 3896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:2.17 (3.5%) stddev-sans-first:2.30 11:26:32 INFO - PROCESS | 3896 | Values: 62.0 67.0 62.0 61.0 61.0 62.0 61.0 64.0 65.0 60.0 11:26:32 INFO - PROCESS | 3896 | -------- Summary: end -------- 11:26:32 INFO - PROCESS | 3896 | 11:26:33 INFO - TEST-INFO | 3896: exit 0 11:26:33 INFO - TEST-OK | kraken | took 59647ms 11:26:33 INFO - SUITE-END | took 1172s 11:26:33 INFO - Completed test suite (00:19:32) 11:26:33 INFO - javascript benchmark 11:26:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.7521798256143, 3130.7495400367966, 3155.226969392499, 3170.0172946386638, 3187.091678871522, 5473.06957817171, 5570.387257401692, 5581.330240371156, 5588.469095435927, 5603.9999999999945, 5672.290963629546, 5754.309482862062, 5754.482096611315, 5757.539396848252, 5760.45275698809, 5160.801439759908, 5223.320968274138, 5230.7646155922885, 5242.2136679498, 5272.92090618641, 4923.507649235065, 5306.09796334624, 5313.1233346497975, 5315.123004704219, 5341.412444631087, 4924.4583095859425, 5028.220625802988, 5081.1108056090225, 5115.872103197413, 5176.404713457944, 5165.457626949154, 5180.766865491043, 5260.500252476008, 5265.0, 5284.0, 4847.903041939141, 5095.439501654852, 5166.457521960216, 5220.321358223445, 5241.659292145999, 5325.440828712968, 5343.545798607084, 5466.671999680032, 5479.589030822664, 5491.039068163095, 5895.705214739289, 5908.734106965197, 6034.637921724667, 6041.637501749865, 6045.093236014633, 5860.208871802337, 6046.818595442144, 6060.636361818305, 6072.210612620375, 6077.513798896078, 5516.365617953947, 5640.210370548127, 5691.573132015115, 5702.7718891243885, 5750.108733146369, 6281.654509001957, 6303.149074874833, 6316.778912738032, 6323.051542268605, 6323.146375239376, 5544.22380866679, 6055.636661800306, 6057.212562366864, 6059.969700151471, 6063.484603808725, 5644.8871022579315, 5670.489655930986, 5736.827895163152, 5741.598088133874, 5742.31092268922, 5691.9146212806845, 5700.030994730822, 5876.9118463223085, 5916.970415147896, 5935.7625694972585, 5973.701314934236, 6012.909806352908, 6023.397660233942, 6028.819135425944, 6029.879402411927, 4731.716097034189, 4740.739259340769, 4741.35991641124, 4746.857594272177, 4772.284157376352, 3932.646061854447, 3950.822213000422, 4047.3321901886447, 4068.9186216275507, 4187.560306167808, 5735.283089613798, 5738.913916291259, 5739.426057394227, 5741.282339707536, 5772.624779389326, 5973.701314934236, 6017.458428741435, 6019.548533859978, 6019.638821670626, 6024.578279520391, 5451.264079349237, 5491.039068163055, 5669.659820410789, 5736.368999410061, 5738.512226460714, 5274.709890955957, 5338.8932221356135, 5339.839804805862, 5360.571154307724, 5378.327709036371, 6342.429181373698, 6343.841403964938, 6344.175257216532, 6348.269948955929, 6352.364763523703, 5648.4633959773755, 5715.8571035724435, 6175.0, 6193.81418557444, 6195.628262304096, 6060.030395136757, 6061.36355682647, 6092.421219984094, 6277.591956522811, 6282.089097080989, 5913.201717768218, 5918.082697181943, 5971.552133590085, 5975.701214939322, 6019.458248757633, 5634.605577609528, 6047.606905551125, 6053.092036194606, 6053.878922421615, 6055.848603784941, 5589.944100559105, 5882.470577648032, 5910.70446477683, 5929.9110513341475, 6042.8791424170395, 5957.940420595739, 5958.553108516965, 5963.761449541969, 5964.433378829004, 5966.880662386641, 5927.525797936069, 5927.9703601481715, 5930.080837470199, 5930.762769489172, 5932.822015339547, 5665.943340566707, 5667.036603777286, 5833.854153646023, 5887.764489420375, 5901.940980590311, 5796.246487956539, 5820.156077368673, 5826.970865145647, 5831.650100993954, 5832.766689332379], "value": 5547.071115186177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3637998201979, 590.982270531884, 637.7225906730571, 662.1855118204611, 667.9899801502976, 33889.83055084724, 34507.137321566974, 45925.77037114814, 46886.76556617221, 46964.0, 44433.555664443345, 48392.75803620986, 48499.51500484994, 48559.02881942368, 48592.51407485924, 8325.791855203608, 9196.0, 9336.81326373472, 9348.906510934905, 9354.485503297316, 8217.465864718804, 10880.836787448156, 11073.280236784623, 11108.0, 11442.828357574643, 11290.548378064868, 11342.035926946219, 11355.205135640508, 11365.431728413587, 11367.602133925315, 10603.469826508644, 10662.093722033636, 10675.733106672356, 10684.198685098649, 10684.679459616224, 10950.06924411418, 11010.0, 11023.283486573348, 11037.227394082418, 11044.502997365058, 44100.55899440996, 44228.557714422765, 44324.11351772946, 44425.0, 44443.555564444265, 3472.8958131256104, 3560.483729859182, 3560.9821950890077, 3617.457381392786, 3744.9812750936344, 32801.6719832801, 32810.835945820116, 33018.0, 33497.497537536954, 33590.32819343624, 4576.290674945389, 4638.350630911675, 4665.603423708989, 4685.2972054191805, 4753.263244197155, 367719.0, 367941.0, 368024.0, 369272.0, 369554.0, 60637.180884573536, 60926.086108708405, 60938.47653808602, 60940.695296523234, 61022.0, 40120.79939600283, 40352.79823600922, 40750.592494075274, 43075.56924430715, 43110.56889431066, 19536.12087456068, 19751.506212344808, 19778.0, 19778.802211977985, 19779.802201977796, 12300.261984280973, 12524.81212781809, 14385.928070359581, 15129.167895765839, 15244.923775381052, 19579.412617621496, 19911.0, 20024.69962950557, 20153.899230503754, 20163.294284699965, 7292.234315396913, 7397.223291554417, 7452.329290363893, 7507.399408047343, 7518.436117291225, 971.32007594684, 1064.6486659402378, 1131.4003578103618, 1140.863096428434, 1143.3482914738686, 34177.0, 34723.096444164716, 34815.303693926486, 34821.47767783485, 35010.474842877375, 1151.1711567671264, 1197.8838707118475, 1231.587418214908, 1236.202649291202, 1292.476546998467, 17077.0, 18151.727724083885, 18320.358787442376, 18388.26446942134, 18654.16056277471, 587750.0, 593905.0, 598606.0, 599116.0, 606176.0, 61509.38490615126, 62292.06561901575, 62296.37703622996, 62412.687936560025, 62432.68783656143, 1280.6094141286997, 1321.973560528784, 1372.3755691160698, 1392.693607406369, 1440.157507857894, 33314.33371332511, 34756.82621586876, 35106.0, 35392.64607353997, 35709.64290357063, 51885.22172167345, 52788.736056319474, 53003.46996529985, 53025.469745302056, 53040.0, 408482.0, 410286.0, 410428.0, 413620.0, 417936.0, 27012.864935675196, 27467.587986180624, 29829.70170298356, 30295.394092118477, 30601.387972239987, 49488.25767613561, 49545.25682114699, 50144.0, 50251.49748502468, 50648.24027639515, 42235.7888210557, 42432.36351454793, 42607.57392426036, 42866.57133428626, 44078.55921440745, 41629.58370416378, 41841.79079104585, 41900.58099419089, 43401.13197736091, 43942.780286099645, 43107.568924310355, 43130.0, 43555.782221088695, 44029.119417610826, 44203.33694994642, 35628.287434250655, 38228.42657360197, 38417.80791096027, 39036.80481597574, 39443.21113577655, 29334.85332573409, 29495.26261843471, 29659.0, 29736.553951690308, 29754.0], "value": 21264.855846821403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.21267379305516, 413.2190160596471, 422.83509431321784, 425.27702905061403, 431.5360986939039, 18892.0, 19963.201471941124, 20594.48513787156, 20965.47586310343, 21118.683219751714, 20150.496237594067, 20332.89833550834, 20374.592508149828, 20811.479713007146, 20895.37313880586, 5883.0881213411985, 6128.233970753656, 6142.600730952474, 6149.938500615003, 6151.477124444427, 5928.55535834812, 5961.225040744697, 5986.790462333819, 6008.519318454535, 6078.966575682122, 6012.398760123974, 6012.669303188345, 6013.669248191348, 6013.72938217779, 6018.15745795589, 5766.625169363999, 5883.88206240815, 5923.911141332884, 5931.199288096095, 5986.5210783137245, 5368.570514358881, 5368.758405871745, 5381.838544843661, 5385.407605163429, 5387.838364849061, 23834.40413989647, 24123.517529649485, 24203.515929681485, 24424.511509769705, 24585.508289834102, 2573.6525569048313, 2580.780633646142, 2618.384679600292, 2621.659184306047, 2659.6542449481635, 13214.471421143142, 14663.120212787268, 15291.158986255752, 15495.535133946, 15724.29240684172, 1962.4014675523958, 2043.2133628552965, 2063.329417939176, 2067.8759274443582, 2080.2303147835396, 75922.0, 79076.0, 80223.0, 81334.9999999994, 83818.58090709569, 10866.0, 11169.273997190157, 11227.270227435354, 11299.887001130048, 11578.536858525733, 16391.5902102446, 16406.67186656284, 16427.09650969208, 16431.589210269838, 16435.09606971604, 8739.91260087391, 8819.250363719028, 8892.644294228288, 8921.0, 9025.368224224372, 8711.825763484694, 8756.737297881074, 8771.517566533774, 8970.147835955573, 8979.326550508738, 6893.75871844493, 7048.612326321999, 7064.929350706427, 7089.113860767404, 7112.324329188718, 1974.2596526302636, 1989.3435166395054, 1993.1031036033842, 2015.4155294964296, 2063.4928561797487, 982.5185659027026, 1024.3188279793853, 1049.5277125293649, 1062.4050531702271, 1068.391017120234, 20155.798442015686, 20813.37559873176, 20832.79167208339, 20904.79095209059, 21078.262260820797, 1049.627382279295, 1052.2108418685987, 1052.3054783842626, 1071.737424331044, 1082.7130810335268, 10646.840297395545, 11960.40197990097, 12035.699107522381, 12048.75902481963, 12156.0, 537814.0, 543332.0, 543415.0, 561105.0, 568012.0, 78253.0, 79897.60051199707, 81291.0, 81575.59212203902, 81721.0, 1054.7732237568805, 1059.0362769879373, 1059.0944742245424, 1093.830456279278, 1100.8954149355798, 18121.0, 18353.81646183521, 18624.16191271369, 18873.622527549647, 18997.14512846953, 40344.798276008434, 40564.1887162261, 40852.79573602113, 41341.793291033355, 41650.58349416467, 52976.20535691891, 53635.46364536461, 54250.72874635601, 54358.45641543692, 55005.449945501634, 5909.113632955091, 8026.678932842621, 8476.49141051539, 8563.186497282748, 8772.473651580925, 12316.815247771112, 12420.875791241971, 12683.746325073631, 12812.423440944993, 12840.55058072963, 10923.781524369628, 11002.0, 11029.227954043461, 11259.324440533594, 11431.542738290374, 10802.783944321227, 10897.291676041032, 10973.23187376876, 10998.34009959405, 11092.445377730919, 11058.723531911766, 11233.71915702114, 11298.717532061435, 11381.146414019147, 11500.597479088192, 7555.093388793161, 8517.148285171434, 8548.615312310836, 8642.395032347675, 8874.06822283651, 5763.6541807491685, 9940.353876997971, 9988.750281243027, 11412.71468213268, 11622.418879056182], "value": 9601.440228678737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.9670508237298, 1424.693690856466, 1496.2518740629685, 1581.7231984402727, 1821.0712536606327, 8074.636641351139, 9301.581428835701, 9541.188998935082, 9573.473458959763, 9859.507024648758, 9505.667301644444, 9574.329796914202, 9585.2811039172, 9592.232621390289, 9599.664011759589, 2517.2574090643257, 2536.9492610147786, 2541.3900663840636, 2541.5806391945307, 2542.3135753346587, 2457.6436416719566, 2545.4527276635517, 2548.6686730724978, 2556.1053631229015, 2557.5268575313535, 2462.285937078254, 2468.3829042739317, 2521.6091505816626, 2522.230719630521, 2523.570992931206, 2453.3008092693676, 2457.8402403843784, 2468.222509909373, 2500.462400583865, 2502.6120951252583, 2431.112643884987, 2467.432490527171, 2470.7158676752224, 2475.71529274134, 2497.325722055053, 9354.158125768714, 9463.0, 9500.524973751284, 9624.663136790248, 9638.277129215337, 5414.620976531644, 5618.213450116987, 5634.239377684001, 5644.463775941279, 5656.943430565683, 3506.491558723996, 3508.2281897982657, 3549.343371476259, 3579.6599323064265, 3587.0494319005484, 1212.9818052729215, 1222.437678667805, 1243.2975368916623, 1259.4521383198246, 1273.4842388832537, 13887.722245555033, 13946.302684865715, 13959.092658977133, 13993.30033498321, 14005.229712365815, 4762.52374762521, 4768.737719425465, 4812.903741925142, 4927.384076990376, 4952.529509696573, 10771.730706732395, 10781.245312828027, 10782.4069676167, 10783.083437907866, 10792.730181745363, 5567.944320556823, 5591.021571225019, 5591.888162236733, 5593.720313984366, 5602.85992850182, 4398.3402489626815, 4548.113117942035, 4688.929666055012, 4749.216379297446, 5209.322788037531, 4039.091204478969, 4123.083272328815, 4140.23405669952, 4199.664026877843, 4210.7473551587, 1212.1272683667746, 1229.397595178374, 1230.7415442756942, 1246.0903540415366, 1248.1013670157472, 899.7971240221981, 982.4400091947664, 1029.330934892311, 1041.250299784154, 1048.4024106259512, 6454.386833250834, 6572.868542629216, 6608.2730899601, 6663.666816659148, 6794.252632210453, 486.8028448478372, 487.8390131256677, 491.7369207473984, 495.23733450486566, 500.53700327197197, 4336.046069864625, 4378.6278166356215, 4470.530594287618, 4556.954430455653, 4559.908801823945, 11683.123765717604, 11975.580854670045, 12032.338221397908, 12032.458539365749, 12064.034877209802, 11513.827292590619, 11929.224600400947, 11967.281963082243, 11973.580924667594, 11983.88016119845, 8415.410921235454, 8596.785080372916, 8596.78508037304, 8600.311975041981, 8600.526971016654, 6682.799516014527, 6751.189857217166, 6751.831204219738, 6758.42553382968, 6813.8977915330315, 11049.613263535737, 11241.831372529256, 11281.32312061279, 11307.547698091985, 11418.257813242113, 10164.949175254076, 10499.580016799242, 11597.18819682614, 11648.941755291507, 11650.825237621273, 8076.676932922617, 8146.959265203636, 8266.751997440086, 8358.623861926106, 8603.440776349516, 9168.220701240469, 9590.328676992543, 9594.088561586637, 9596.76008099803, 9607.951960240154, 8378.287845532954, 8445.95777021111, 8508.106648801786, 8509.574521273787, 8570.48577085377, 8352.123027082313, 8383.161683831568, 8424.663013479392, 8429.367797415096, 8578.227959483676, 7774.805629859299, 7783.922160778547, 7798.961005194938, 7835.451518393657, 7911.762647120596, 5721.456461636138, 5762.740676669644, 5774.595778295647, 5860.267466566679, 5960.344362120077, 5737.827865164052, 5821.854453638523, 5867.413258674099, 5871.559633027626, 5939.910901336397], "value": 4897.363974652775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.29553346904567, 335.55874025656277, 336.0556835292826, 339.9004221343952, 344.9948250776239, 5586.832395028146, 5616.5787565932515, 5633.478960680613, 5653.915191272124, 5665.971670141648, 5505.752241149148, 5532.75102620382, 5560.165975103737, 5594.510442852922, 5597.916031259524, 4113.753174809521, 4216.852410165645, 4243.469566304212, 4368.432103826498, 4371.103923695635, 4337.262665346882, 4341.41390912226, 4371.519132895379, 4392.714473559208, 4392.780360981954, 4319.250703465102, 4322.113966636847, 4327.588879056485, 4331.397382968306, 4336.63138633215, 4066.8169932352966, 4303.246931786956, 4312.870613881557, 4314.201872653538, 4364.170807546572, 3793.3551296279697, 3794.962050379516, 3800.6959443244473, 3802.4676545283683, 3813.656770890633, 5433.4566543345745, 5450.945490545084, 5453.727313634303, 5479.780808767645, 5485.61600687952, 4817.927731084036, 4845.885446347324, 4877.414970065871, 4917.606591472673, 4953.356063711694, 5686.857828554278, 5702.0, 5703.201551782754, 5729.255196824428, 5740.856478588027, 4125.690573207022, 4127.050778320973, 4131.029208136086, 4138.213739389536, 4165.146145040259, 5853.970730146365, 5931.911021334683, 5954.523638108941, 6001.489128859623, 6031.849203769897, 4131.814068366931, 4157.958420415817, 4165.625093741578, 4169.1661667666585, 4195.517515485697, 4226.372846454075, 4246.554111818215, 4274.871753847389, 4280.892977675583, 4290.163418133497, 4669.0, 4807.230843065093, 4842.685225460334, 4909.631777616693, 4912.484189160158, 5731.312242530923, 5760.164776107441, 5764.5676574257095, 5767.682777447197, 5773.70091729366, 1432.9641758956109, 1442.8773554247796, 1452.1722618107788, 1471.4996901053694, 1476.0184477322675, 899.0559912092277, 911.4576826788051, 942.0767647705151, 951.6716732727198, 972.3436680240809, 5474.233607294902, 5596.901162064226, 5616.719164041781, 5643.40744221859, 5664.54683625309, 5994.970025149846, 6006.759729610854, 6007.669578173155, 6014.368491308437, 6059.212302400748, 5493.835184944458, 5662.754194077296, 5681.744321505542, 5705.771769129271, 5705.942940570624, 3149.7165255127147, 3158.368326334742, 3166.699163579456, 3173.4767311690516, 3193.9361212775616, 5875.384269325969, 5998.340182579913, 6072.939270607238, 6085.6348619083, 6147.754089836446, 5948.839976204685, 5998.220231369981, 6040.848978775478, 6047.3045599755715, 6048.183495228176, 6072.36240194782, 6104.38956104386, 6112.380219241904, 6159.353267906805, 6185.319614842454, 5795.507381872588, 5892.292924849045, 5925.40745925404, 5936.465718085393, 5997.370276121119, 5815.534757219328, 5834.737436815269, 5884.58807883444, 5887.587868849139, 5896.70516474166, 5929.525637948867, 6048.90926636092, 6084.269887613515, 6095.238095238095, 6154.969225153845, 4270.423492828429, 4284.357346398066, 4299.677524185636, 4310.568943105664, 4331.675124365748, 5954.3152537458745, 5981.2822461303185, 6006.759729610767, 6012.8797424052145, 6023.30731965812, 5617.382087970402, 5773.3072031356505, 5832.183494310715, 5841.18223448709, 5915.112733090071, 5769.0, 5770.2498675171955, 5784.82645520635, 5793.188953546591, 5822.155787410887, 5642.605017648725, 5764.36591974874, 5773.480386765212, 5812.622179558484, 5840.649561026352, 5722.0272553665145, 5809.970950145392, 5814.680192589448, 5816.749398879261, 5837.211976383134, 5687.431256874445, 5689.829305120853, 5690.374058853606, 5696.401877802937, 5745.597808153389], "value": 4413.201416913135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.2176420941186, 676.6616691654173, 696.7456878239443, 705.2312978853049, 747.8669815229928, 14931.925340373296, 16047.438339658114, 16065.919670401661, 16071.035737855707, 16179.271932763024, 14686.339114739836, 14819.259037048132, 14845.257737113128, 14851.183184924852, 14862.925685371558, 705.3898377903129, 723.3345322303494, 738.4240292571802, 829.6930135849744, 853.9018012928531, 850.090403268503, 851.6040041380757, 857.1086070486717, 857.1428571428571, 857.4598003257938, 912.2792993535099, 914.5290175559592, 914.7850255190025, 914.9771255718628, 915.1306259053893, 905.6784841381346, 906.8775715278452, 907.7866701325183, 908.246155690775, 908.5184852028402, 671.392389887153, 671.7413795688647, 671.758167059858, 672.1228796420669, 672.3780503034674, 14088.788668169986, 14100.365483553265, 14104.294785260696, 14122.646933826634, 14127.293635318296, 15381.92309038459, 15811.762823557656, 15863.841361586352, 15999.285214361262, 16250.02499850001, 13008.284544350057, 13143.934280328633, 13175.20948743069, 13244.735105297936, 13249.735005299937, 4128.855490057834, 4150.792460376969, 4224.112936283384, 4243.681723870691, 4253.425787518676, 68910.31089689139, 70593.9410908842, 86133.56933215357, 88408.0, 88764.55617721935, 11894.226875253082, 11915.285082895054, 12073.0, 12083.275003499819, 12257.325847078497, 22439.32682019542, 22451.663225051638, 22638.773612263994, 23057.654135187986, 23088.307350779167, 8395.706150284834, 8491.448055876348, 8741.213290803858, 9252.398594091363, 9768.951155244178, 4815.253635686474, 4838.225883858566, 4985.55130038291, 5049.2173713074535, 5049.2426136079885, 3443.5523381960184, 3572.4284114541547, 3574.9285014299567, 3577.177249232691, 3577.266660334625, 569.1718549510452, 577.1314172170856, 585.2917969257246, 591.3879135095156, 595.9970200148972, 720.2545365546634, 726.7311094894923, 729.956202627844, 730.2369024369547, 745.5079647432668, 9296.256299496024, 9794.216462682969, 10097.293189476813, 10322.587096516205, 10599.417032063157, 504.3972452918727, 554.6062295770048, 618.8236352639476, 618.8669436071176, 623.9704487595503, 4686.484486706459, 4718.669693121448, 4733.573978341966, 4787.688800227974, 4791.161546729309, 128361.71638283685, 131329.0, 132227.0, 134974.32512837372, 140030.0, 65083.67458162679, 98429.0, 118721.40639296749, 119548.40225798989, 120927.0, 101443.0, 103687.48156259171, 106001.0, 107070.46464767626, 108124.0, 9114.817703646022, 9288.58201380953, 9369.718908432758, 9522.714318570454, 9648.324617276723, 60776.392236077074, 61753.38246617656, 62533.0, 62652.373476264656, 63359.6832015837, 70049.0, 70662.0, 71144.64427677829, 76586.6170669143, 91840.0, 12541.874581254071, 12654.620361389174, 12703.745925081632, 12778.105532612628, 13305.866941330463, 14877.776833347292, 15086.54740357791, 15133.167675777497, 15301.0, 15410.152441615819, 14388.20864852443, 14497.20265385414, 14611.561653150422, 14717.55847324582, 14958.775618365951, 12874.291913944822, 12964.157329773534, 13105.606831795061, 13210.471581136648, 13402.865971340161, 13233.470661173445, 13344.399502022627, 13918.721625567634, 13919.512817051354, 14402.783958240845, 11775.941120294687, 12030.578929737418, 12226.510939562673, 12253.69365765863, 12517.371352015814, 11276.830847537129, 12155.939220304195, 12414.62756117318, 12674.746505069663, 12758.553450629184], "value": 7835.064678684789, "unit": "score"}], "name": "dromaeo_css", "value": 7594.119615164332, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 109.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 120.0, 156.0, 120.0, 117.0, 115.0, 117.0, 159.0, 116.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 163.0, 162.0, 163.0, 163.0, 162.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 103.0, 76.0, 76.0, 77.0, 76.0, 100.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 81.0, 108.0, 82.0, 82.0, 82.0, 99.0, 82.0, 86.0, 120.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 50.0, 50.0, 49.0, 51.0, 51.0, 51.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 78.0, 76.0, 79.0, 74.0, 74.0, 73.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 125.0, 126.0, 130.0, 121.0, 120.0, 119.0, 154.0, 129.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 153.0, 153.0, 156.0, 151.0, 151.0, 156.0, 155.0, 151.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 62.0, 61.0, 61.0, 62.0, 61.0, 64.0, 65.0, 60.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1458.7, "alertThreshold": 2.0}]} 11:26:33 INFO - Return code: 0 11:26:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:33 INFO - # TBPL SUCCESS # 11:26:33 INFO - Running post-action listener: _resource_record_post_action 11:26:33 INFO - [mozharness: 2016-12-02 19:26:33.869191Z] Finished run-tests step (success) 11:26:33 INFO - Running post-run listener: _resource_record_post_run 11:26:33 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1732608; Write bytes: 321708032; Read time: 60; Write time: 167108 11:26:33 INFO - TinderboxPrint: CPU usage
12.9% 11:26:33 INFO - TinderboxPrint: I/O read bytes / time
1,732,608 / 60 11:26:33 INFO - TinderboxPrint: I/O write bytes / time
321,708,032 / 167,108 11:26:33 INFO - TinderboxPrint: CPU idle
8,243.8 (87.1%) 11:26:33 INFO - TinderboxPrint: CPU user
1,181.5 (12.5%) 11:26:33 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 102440960; Read time: 0; Write time: 54912 11:26:33 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 219267072; Read time: 0; Write time: 112196 11:26:34 INFO - Running post-run listener: _upload_blobber_files 11:26:34 INFO - Blob upload gear active. 11:26:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:34 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 11:26:34 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:34 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:38 INFO - (blobuploader) - INFO - Done attempting. 11:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:39 INFO - (blobuploader) - INFO - Done attempting. 11:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:40 INFO - (blobuploader) - INFO - Done attempting. 11:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:40 INFO - Return code: 0 11:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7bf6f78d5f193de4deed61aed3b602e36fb9b2b2a441653ebfc9afb97a391ccbd56471af7b21c32358b8145cf2f3388e996c63a646815c44867e3cff324a401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/65a728c5bd265c046d05025ae0781809fade1e2ee6b6131eb5611923807f7d1a4cb459facd0d60906d52ca59f6a6939d29c6a31116c6fee7d163ad4e327d5819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24c06767af2550e7b4eb3ebde0b2765c476ef318f8b238c0fc24fb2252003f3803b2bbc6137111a0138813780890fbe831a1f857e198f24a55ab5bcd7ff157a4"} 11:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:40 INFO - Contents: 11:26:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7bf6f78d5f193de4deed61aed3b602e36fb9b2b2a441653ebfc9afb97a391ccbd56471af7b21c32358b8145cf2f3388e996c63a646815c44867e3cff324a401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/65a728c5bd265c046d05025ae0781809fade1e2ee6b6131eb5611923807f7d1a4cb459facd0d60906d52ca59f6a6939d29c6a31116c6fee7d163ad4e327d5819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24c06767af2550e7b4eb3ebde0b2765c476ef318f8b238c0fc24fb2252003f3803b2bbc6137111a0138813780890fbe831a1f857e198f24a55ab5bcd7ff157a4"} 11:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:40 INFO - Copying logs to upload dir... 11:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.304097 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-12-02 11:26:40.304949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 11:26:40.308496) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7bf6f78d5f193de4deed61aed3b602e36fb9b2b2a441653ebfc9afb97a391ccbd56471af7b21c32358b8145cf2f3388e996c63a646815c44867e3cff324a401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/65a728c5bd265c046d05025ae0781809fade1e2ee6b6131eb5611923807f7d1a4cb459facd0d60906d52ca59f6a6939d29c6a31116c6fee7d163ad4e327d5819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24c06767af2550e7b4eb3ebde0b2765c476ef318f8b238c0fc24fb2252003f3803b2bbc6137111a0138813780890fbe831a1f857e198f24a55ab5bcd7ff157a4"} build_url:https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/PRqCPx3ARPWwK7bhva7-Eg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a7bf6f78d5f193de4deed61aed3b602e36fb9b2b2a441653ebfc9afb97a391ccbd56471af7b21c32358b8145cf2f3388e996c63a646815c44867e3cff324a401", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/65a728c5bd265c046d05025ae0781809fade1e2ee6b6131eb5611923807f7d1a4cb459facd0d60906d52ca59f6a6939d29c6a31116c6fee7d163ad4e327d5819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/24c06767af2550e7b4eb3ebde0b2765c476ef318f8b238c0fc24fb2252003f3803b2bbc6137111a0138813780890fbe831a1f857e198f24a55ab5bcd7ff157a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 11:26:40.333145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:26:40.333447) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1480705568.682512-85996971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 11:26:40.385587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 11:26:40.385905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 11:26:40.386201) ========= ========= Total master_lag: -0.00 =========