builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1490701055.74 results: success (0) revision: bf0f897261395ed2488f8fef72cf5353da1e105e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:35.738923) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:35.739372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:35.739643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:35.754555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 04:37:35.754916) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-28 04:37:35-- 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% 37.2M=0s 2017-03-28 04:37:36 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.118755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 04:37:36.887918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:36.888323) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013471 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:36.937623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2017-03-28 04:37:36.937958) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf0f897261395ed2488f8fef72cf5353da1e105e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev bf0f897261395ed2488f8fef72cf5353da1e105e --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=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-28 04:37:36,998 truncating revision to first 12 chars 2017-03-28 04:37:36,998 Setting DEBUG logging. 2017-03-28 04:37:36,998 attempt 1/10 2017-03-28 04:37:36,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf0f89726139?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 04:37:43,846 unpacking tar archive at: mozilla-central-bf0f89726139/testing/mozharness/ program finished with exit code 0 elapsedTime=7.162581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2017-03-28 04:37:44.113035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:44.113345) ========= script_repo_revision: bf0f897261395ed2488f8fef72cf5353da1e105e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:44.113725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:44.113984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 04:37:44.121820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2017-03-28 04:37:44.122189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:37:44 INFO - MultiFileLogger online at 20170328 04:37:44 in /builds/slave/test 04:37:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:44 INFO - {'append_to_log': False, 04:37:44 INFO - 'base_work_dir': '/builds/slave/test', 04:37:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:44 INFO - 'branch': 'Firefox-Non-PGO', 04:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:44 INFO - 'config_files': ('talos/linux_config.py',), 04:37:44 INFO - 'default_actions': ('clobber', 04:37:44 INFO - 'read-buildbot-config', 04:37:44 INFO - 'download-and-extract', 04:37:44 INFO - 'populate-webroot', 04:37:44 INFO - 'create-virtualenv', 04:37:44 INFO - 'install', 04:37:44 INFO - 'run-tests'), 04:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:44 INFO - 'download_minidump_stackwalk': True, 04:37:44 INFO - 'download_symbols': 'ondemand', 04:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:44 INFO - 'gecko_profile': False, 04:37:44 INFO - 'gecko_profile_interval': 0, 04:37:44 INFO - 'installer_path': 'installer.exe', 04:37:44 INFO - 'log_level': 'info', 04:37:44 INFO - 'log_name': 'talos', 04:37:44 INFO - 'log_to_console': True, 04:37:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:37:44 INFO - 'opt_config_files': (), 04:37:44 INFO - 'pip_index': False, 04:37:44 INFO - 'suite': 'dromaeojs-e10s', 04:37:44 INFO - 'system_bits': '32', 04:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:44 INFO - 'title': 'talos-linux64-ix-071', 04:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:44 INFO - 'use_talos_json': True, 04:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:44 INFO - 'work_dir': 'build'} 04:37:44 INFO - [mozharness: 2017-03-28 11:37:44.275749Z] Running clobber step. 04:37:44 INFO - Running pre-action listener: _resource_record_pre_action 04:37:44 INFO - Running main action method: clobber 04:37:44 INFO - rmtree: /builds/slave/test/build 04:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - [mozharness: 2017-03-28 11:37:45.205467Z] Finished clobber step (success) 04:37:45 INFO - [mozharness: 2017-03-28 11:37:45.205568Z] Running read-buildbot-config step. 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: read_buildbot_config 04:37:45 INFO - Using buildbot properties: 04:37:45 INFO - { 04:37:45 INFO - "project": "", 04:37:45 INFO - "product": "firefox", 04:37:45 INFO - "who": "cbook@mozilla.com", 04:37:45 INFO - "installer_path": "public/build/target.tar.bz2", 04:37:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:37:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:37:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:37:45 INFO - "stage_platform": "linux64", 04:37:45 INFO - "basedir": "/builds/slave/test", 04:37:45 INFO - "buildnumber": 739, 04:37:45 INFO - "platform": "ubuntu64_hw", 04:37:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:37:45 INFO - "slavebuilddir": "test", 04:37:45 INFO - "taskId": "VcwUDI6zSjiwnxDOXEgvgA", 04:37:45 INFO - "branch": "mozilla-central", 04:37:45 INFO - "script_repo_revision": "production", 04:37:45 INFO - "revision": "bf0f897261395ed2488f8fef72cf5353da1e105e", 04:37:45 INFO - "slavename": "talos-linux64-ix-071", 04:37:45 INFO - "repo_path": "mozilla-central" 04:37:45 INFO - } 04:37:45 INFO - Finding installer, test and symbols from parent task. 04:37:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VcwUDI6zSjiwnxDOXEgvgA'}, attempt #1 04:37:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VcwUDI6zSjiwnxDOXEgvgA'}, attempt #1 04:37:49 INFO - Task dependencies: d69pDPH3QQKu4zQ0a1sOOQ 04:37:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ'}, attempt #1 04:37:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 04:37:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/test_packages.json 04:37:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.crashreporter-symbols.zip 04:37:50 INFO - Running post-action listener: _resource_record_post_action 04:37:50 INFO - [mozharness: 2017-03-28 11:37:50.961835Z] Finished read-buildbot-config step (success) 04:37:50 INFO - [mozharness: 2017-03-28 11:37:50.962053Z] Running download-and-extract step. 04:37:50 INFO - Running pre-action listener: _resource_record_pre_action 04:37:50 INFO - Running main action method: download_and_extract 04:37:50 INFO - mkdir: /builds/slave/test/build/tests 04:37:50 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')]} 04:37:50 INFO - trying https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.test_packages.json 04:37:50 INFO - Downloading https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:37:53 INFO - Downloaded 986 bytes. 04:37:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:37:53 INFO - Using the following test package requirements: 04:37:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:37:53 INFO - u'common': [u'target.common.tests.zip'], 04:37:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:37:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:37:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:37:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:37:53 INFO - u'mozbase': [u'target.common.tests.zip'], 04:37:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:37:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:37:53 INFO - u'web-platform': [u'target.common.tests.zip', 04:37:53 INFO - u'target.web-platform.tests.zip'], 04:37:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:37:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:37:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip 04:37:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:37:53 INFO - Fetch https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip into memory 04:37:57 INFO - Expected file size: 58220247 04:37:57 INFO - Obtained file size: 58220247 04:38:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:38:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip 04:38:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:38:06 INFO - Fetch https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.common.tests.zip into memory 04:38:09 INFO - Expected file size: 58220247 04:38:09 INFO - Obtained file size: 58220247 04:38:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.talos.tests.zip 04:38:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:38:21 INFO - Fetch https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.talos.tests.zip into memory 04:38:45 INFO - Expected file size: 14404171 04:38:45 INFO - Obtained file size: 14404171 04:38: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')]} 04:38:46 INFO - trying https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 04:38:46 INFO - Downloading https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:38:49 INFO - Downloaded 62584273 bytes. 04:38:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 04:38:49 INFO - mkdir: /builds/slave/test/properties 04:38:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:49 INFO - Contents: 04:38:49 INFO - build_url:https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 04:38:49 INFO - Running post-action listener: _resource_record_post_action 04:38:49 INFO - Running post-action listener: set_extra_try_arguments 04:38:49 INFO - [mozharness: 2017-03-28 11:38:49.842962Z] Finished download-and-extract step (success) 04:38:49 INFO - [mozharness: 2017-03-28 11:38:49.843058Z] Running populate-webroot step. 04:38:49 INFO - Running pre-action listener: _resource_record_pre_action 04:38:49 INFO - Running main action method: populate_webroot 04:38:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:49 INFO - '--tppagecycles', 04:38:49 INFO - '7'], 04:38:49 INFO - 'tests': ['tsvgm']}}, 04:38:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:38:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:38:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['damp', 'tps']}, 04:38:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'tests': ['damp', 'tps']}, 04:38:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['dromaeo_dom']}, 04:38:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['basic_compositor_video']}, 04:38:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:38:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['a11yr', 04:38:49 INFO - 'ts_paint', 04:38:49 INFO - 'tpaint', 04:38:49 INFO - 'sessionrestore', 04:38:49 INFO - 'sessionrestore_no_auto_restore', 04:38:49 INFO - 'tabpaint']}, 04:38:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tsvgx', 04:38:49 INFO - 'tsvgr_opacity', 04:38:49 INFO - 'tart', 04:38:49 INFO - 'tscrollx', 04:38:49 INFO - 'cart', 04:38:49 INFO - 'tsvg_static']}, 04:38:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:38:49 INFO - 'tsvgr_opacity', 04:38:49 INFO - 'tart', 04:38:49 INFO - 'tscrollx', 04:38:49 INFO - 'cart', 04:38:49 INFO - 'tsvg_static']}, 04:38:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s'], 04:38:49 INFO - 'tests': ['tp5o']}, 04:38:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:38:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'talos_options': ['--disable-e10s', 04:38:49 INFO - '--xperf_path', 04:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:49 INFO - 'tests': ['tp5n']}, 04:38:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:38:49 INFO - 'talos_options': ['--xperf_path', 04:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:49 INFO - 'tests': ['tp5n']}}, 04:38:49 INFO - 'talos.zip': {'path': '', 04:38:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:49 INFO - Running post-action listener: _resource_record_post_action 04:38:49 INFO - [mozharness: 2017-03-28 11:38:49.856129Z] Finished populate-webroot step (success) 04:38:49 INFO - [mozharness: 2017-03-28 11:38:49.856218Z] Running create-virtualenv step. 04:38:49 INFO - Running pre-action listener: _resource_record_pre_action 04:38:49 INFO - Running main action method: create_virtualenv 04:38:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:49 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 04:38:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:49 INFO - Using real prefix '/usr' 04:38:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:52 INFO - Installing pip.................done. 04:38:52 INFO - Return code: 0 04:38:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:38:52 INFO - Reading from file tmpfile_stdout 04:38:52 INFO - Output received: 04:38:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:38:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:55 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:38:55 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 04:38:55 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 04:38:55 INFO - Using env: {'DISPLAY': ':0', 04:38:55 INFO - 'HOME': '/home/cltbld', 04:38:55 INFO - 'LANG': 'en_US.UTF-8', 04:38:55 INFO - 'LANGUAGE': 'en_US:en', 04:38:55 INFO - 'LOGNAME': 'cltbld', 04:38:55 INFO - 'MAIL': '/var/mail/cltbld', 04:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:55 INFO - 'MOZ_NO_REMOTE': '1', 04:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:55 INFO - 'NO_EM_RESTART': '1', 04:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:56 INFO - 'PWD': '/builds/slave/test', 04:38:56 INFO - 'SHELL': '/bin/bash', 04:38:56 INFO - 'SHLVL': '1', 04:38:56 INFO - 'TERM': 'linux', 04:38:56 INFO - 'TMOUT': '86400', 04:38:56 INFO - 'USER': 'cltbld', 04:38:56 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:56 INFO - '_': '/tools/buildbot/bin/python'} 04:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:56 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 04:38:56 INFO - Cleaning up... 04:38:56 INFO - Return code: 0 04:38:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:59 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:38:59 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 04:38:59 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 04:38:59 INFO - Using env: {'DISPLAY': ':0', 04:38:59 INFO - 'HOME': '/home/cltbld', 04:38:59 INFO - 'LANG': 'en_US.UTF-8', 04:38:59 INFO - 'LANGUAGE': 'en_US:en', 04:38:59 INFO - 'LOGNAME': 'cltbld', 04:38:59 INFO - 'MAIL': '/var/mail/cltbld', 04:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:59 INFO - 'MOZ_NO_REMOTE': '1', 04:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:59 INFO - 'NO_EM_RESTART': '1', 04:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:59 INFO - 'PWD': '/builds/slave/test', 04:38:59 INFO - 'SHELL': '/bin/bash', 04:38:59 INFO - 'SHLVL': '1', 04:38:59 INFO - 'TERM': 'linux', 04:38:59 INFO - 'TMOUT': '86400', 04:38:59 INFO - 'USER': 'cltbld', 04:38:59 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:59 INFO - '_': '/tools/buildbot/bin/python'} 04:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:59 INFO - Downloading/unpacking psutil>=3.1.1 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:05 INFO - Installing collected packages: psutil 04:39:05 INFO - Running setup.py install for psutil 04:39:05 INFO - building 'psutil._psutil_linux' extension 04:39:05 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 04:39:05 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 04:39:05 INFO - building 'psutil._psutil_posix' extension 04:39:05 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 04:39:05 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 04:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:06 INFO - Successfully installed psutil 04:39:06 INFO - Cleaning up... 04:39:06 INFO - Return code: 0 04:39:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:06 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')]} 04:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:06 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')]} 04:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:09 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 04:39:09 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 04:39:09 INFO - Using env: {'DISPLAY': ':0', 04:39:09 INFO - 'HOME': '/home/cltbld', 04:39:09 INFO - 'LANG': 'en_US.UTF-8', 04:39:09 INFO - 'LANGUAGE': 'en_US:en', 04:39:09 INFO - 'LOGNAME': 'cltbld', 04:39:09 INFO - 'MAIL': '/var/mail/cltbld', 04:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:09 INFO - 'MOZ_NO_REMOTE': '1', 04:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:09 INFO - 'NO_EM_RESTART': '1', 04:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:09 INFO - 'PWD': '/builds/slave/test', 04:39:09 INFO - 'SHELL': '/bin/bash', 04:39:09 INFO - 'SHLVL': '1', 04:39:09 INFO - 'TERM': 'linux', 04:39:09 INFO - 'TMOUT': '86400', 04:39:09 INFO - 'USER': 'cltbld', 04:39:09 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:09 INFO - '_': '/tools/buildbot/bin/python'} 04:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:09 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 04:39:09 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 04:39:09 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 04:39:09 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 04:39:09 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 04:39:09 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 04:39:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:15 INFO - Installing collected packages: mozsystemmonitor 04:39:15 INFO - Running setup.py install for mozsystemmonitor 04:39:15 INFO - Successfully installed mozsystemmonitor 04:39:15 INFO - Cleaning up... 04:39:15 INFO - Return code: 0 04:39:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39:15 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')]} 04:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:15 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')]} 04:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:39:18 INFO - Using env: {'DISPLAY': ':0', 04:39:18 INFO - 'HOME': '/home/cltbld', 04:39:18 INFO - 'LANG': 'en_US.UTF-8', 04:39:18 INFO - 'LANGUAGE': 'en_US:en', 04:39:18 INFO - 'LOGNAME': 'cltbld', 04:39:18 INFO - 'MAIL': '/var/mail/cltbld', 04:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:18 INFO - 'MOZ_NO_REMOTE': '1', 04:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:18 INFO - 'NO_EM_RESTART': '1', 04:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:18 INFO - 'PWD': '/builds/slave/test', 04:39:18 INFO - 'SHELL': '/bin/bash', 04:39:18 INFO - 'SHLVL': '1', 04:39:18 INFO - 'TERM': 'linux', 04:39:18 INFO - 'TMOUT': '86400', 04:39:18 INFO - 'USER': 'cltbld', 04:39:18 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:18 INFO - '_': '/tools/buildbot/bin/python'} 04:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:24 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 04:39:24 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 04:39:24 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 04:39:24 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 04:39:24 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 04:39:24 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 04:39:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:25 INFO - warning: no files found matching '*.txt' 04:39:25 INFO - no previously-included directories found matching 'build' 04:39:25 INFO - no previously-included directories found matching 'dist' 04:39:25 INFO - no previously-included directories found matching '.git*' 04:39:25 INFO - Installing collected packages: jsonschema, functools32 04:39:25 INFO - Running setup.py install for functools32 04:39:25 INFO - warning: no files found matching '*.txt' 04:39:25 INFO - no previously-included directories found matching 'build' 04:39:25 INFO - no previously-included directories found matching 'dist' 04:39:25 INFO - no previously-included directories found matching '.git*' 04:39:25 INFO - Successfully installed jsonschema functools32 04:39:25 INFO - Cleaning up... 04:39:25 INFO - Return code: 0 04:39:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:39:25 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')]} 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 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')]} 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:28 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 04:39:28 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 04:39:28 INFO - Using env: {'DISPLAY': ':0', 04:39:28 INFO - 'HOME': '/home/cltbld', 04:39:28 INFO - 'LANG': 'en_US.UTF-8', 04:39:28 INFO - 'LANGUAGE': 'en_US:en', 04:39:28 INFO - 'LOGNAME': 'cltbld', 04:39:28 INFO - 'MAIL': '/var/mail/cltbld', 04:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:29 INFO - 'MOZ_NO_REMOTE': '1', 04:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:29 INFO - 'NO_EM_RESTART': '1', 04:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:29 INFO - 'PWD': '/builds/slave/test', 04:39:29 INFO - 'SHELL': '/bin/bash', 04:39:29 INFO - 'SHLVL': '1', 04:39:29 INFO - 'TERM': 'linux', 04:39:29 INFO - 'TMOUT': '86400', 04:39:29 INFO - 'USER': 'cltbld', 04:39:29 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:29 INFO - '_': '/tools/buildbot/bin/python'} 04:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:39:29 INFO - Cleaning up... 04:39:29 INFO - Return code: 0 04:39:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:29 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')]} 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 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')]} 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', '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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39: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 blobuploader==1.2.4 04:39:32 INFO - Using env: {'DISPLAY': ':0', 04:39:32 INFO - 'HOME': '/home/cltbld', 04:39:32 INFO - 'LANG': 'en_US.UTF-8', 04:39:32 INFO - 'LANGUAGE': 'en_US:en', 04:39:32 INFO - 'LOGNAME': 'cltbld', 04:39:32 INFO - 'MAIL': '/var/mail/cltbld', 04:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:32 INFO - 'MOZ_NO_REMOTE': '1', 04:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:32 INFO - 'NO_EM_RESTART': '1', 04:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:32 INFO - 'PWD': '/builds/slave/test', 04:39:32 INFO - 'SHELL': '/bin/bash', 04:39:32 INFO - 'SHLVL': '1', 04:39:32 INFO - 'TERM': 'linux', 04:39:32 INFO - 'TMOUT': '86400', 04:39:32 INFO - 'USER': 'cltbld', 04:39:32 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:32 INFO - '_': '/tools/buildbot/bin/python'} 04:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:32 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 04:39:32 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 04:39:32 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 04:39:32 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 04:39:32 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 04:39:32 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 04:39:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 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 04:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:40 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 04:39:40 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 04:39:40 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 04:39:40 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 04:39:40 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 04:39:40 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 04:39:40 INFO - Downloading docopt-0.6.1.tar.gz 04:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:40 INFO - Running setup.py install for blobuploader 04:39:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:40 INFO - Running setup.py install for requests 04:39:40 INFO - Running setup.py install for docopt 04:39:40 INFO - Successfully installed blobuploader requests docopt 04:39:40 INFO - Cleaning up... 04:39:40 INFO - Return code: 0 04:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:43 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:43 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 04:39:43 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 04:39:43 INFO - Using env: {'DISPLAY': ':0', 04:39:43 INFO - 'HOME': '/home/cltbld', 04:39:43 INFO - 'LANG': 'en_US.UTF-8', 04:39:43 INFO - 'LANGUAGE': 'en_US:en', 04:39:43 INFO - 'LOGNAME': 'cltbld', 04:39:43 INFO - 'MAIL': '/var/mail/cltbld', 04:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:43 INFO - 'MOZ_NO_REMOTE': '1', 04:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:43 INFO - 'NO_EM_RESTART': '1', 04:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:43 INFO - 'PWD': '/builds/slave/test', 04:39:43 INFO - 'SHELL': '/bin/bash', 04:39:43 INFO - 'SHLVL': '1', 04:39:43 INFO - 'TERM': 'linux', 04:39:43 INFO - 'TMOUT': '86400', 04:39:43 INFO - 'USER': 'cltbld', 04:39:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:43 INFO - '_': '/tools/buildbot/bin/python'} 04:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:43 INFO - Running setup.py (path:/tmp/pip-uQ5R0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:43 INFO - Running setup.py (path:/tmp/pip-5p9PTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:43 INFO - Running setup.py (path:/tmp/pip-1JDO1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:43 INFO - Running setup.py (path:/tmp/pip-JOJzsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:43 INFO - Running setup.py (path:/tmp/pip-oZf4Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:43 INFO - Running setup.py (path:/tmp/pip-DUKS46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:43 INFO - Running setup.py (path:/tmp/pip-FFuNkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:43 INFO - Running setup.py (path:/tmp/pip-cfFBwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:43 INFO - Running setup.py (path:/tmp/pip-P4hlX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:44 INFO - Running setup.py (path:/tmp/pip-4xuVbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:44 INFO - Running setup.py (path:/tmp/pip-QCwIjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:44 INFO - Running setup.py (path:/tmp/pip-RTtyyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:44 INFO - Running setup.py (path:/tmp/pip-NRfIG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:44 INFO - Running setup.py (path:/tmp/pip-jYTaEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:44 INFO - Running setup.py (path:/tmp/pip-Ixt_6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:44 INFO - Running setup.py (path:/tmp/pip-L83iR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:44 INFO - Running setup.py (path:/tmp/pip-Vn3lIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:44 INFO - Running setup.py install for manifestparser 04:39:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:44 INFO - Running setup.py install for mozcrash 04:39:44 INFO - Running setup.py install for mozdebug 04:39:44 INFO - Running setup.py install for mozdevice 04:39:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozfile 04:39:45 INFO - Running setup.py install for mozhttpd 04:39:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozinfo 04:39:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozInstall 04:39:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozleak 04:39:45 INFO - Running setup.py install for mozlog 04:39:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for moznetwork 04:39:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozprocess 04:39:45 INFO - Running setup.py install for mozprofile 04:39:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:45 INFO - Running setup.py install for mozrunner 04:39:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:46 INFO - Running setup.py install for mozscreenshot 04:39:46 INFO - Running setup.py install for moztest 04:39:46 INFO - Running setup.py install for mozversion 04:39:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:46 INFO - Cleaning up... 04:39:46 INFO - Return code: 0 04:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:48 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:48 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 04:39:48 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 04:39:48 INFO - Using env: {'DISPLAY': ':0', 04:39:48 INFO - 'HOME': '/home/cltbld', 04:39:48 INFO - 'LANG': 'en_US.UTF-8', 04:39:48 INFO - 'LANGUAGE': 'en_US:en', 04:39:48 INFO - 'LOGNAME': 'cltbld', 04:39:48 INFO - 'MAIL': '/var/mail/cltbld', 04:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:48 INFO - 'MOZ_NO_REMOTE': '1', 04:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:48 INFO - 'NO_EM_RESTART': '1', 04:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:48 INFO - 'PWD': '/builds/slave/test', 04:39:48 INFO - 'SHELL': '/bin/bash', 04:39:48 INFO - 'SHLVL': '1', 04:39:48 INFO - 'TERM': 'linux', 04:39:48 INFO - 'TMOUT': '86400', 04:39:48 INFO - 'USER': 'cltbld', 04:39:48 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:48 INFO - '_': '/tools/buildbot/bin/python'} 04:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:49 INFO - Running setup.py (path:/tmp/pip-fCkIYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:49 INFO - Running setup.py (path:/tmp/pip-t1V3Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:49 INFO - Running setup.py (path:/tmp/pip-cVXe3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:49 INFO - Running setup.py (path:/tmp/pip-3GUGkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:49 INFO - Running setup.py (path:/tmp/pip-BX5NdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:49 INFO - Running setup.py (path:/tmp/pip-jFyYyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:49 INFO - Running setup.py (path:/tmp/pip-Cud2LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:49 INFO - Running setup.py (path:/tmp/pip-4H2pX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:49 INFO - Running setup.py (path:/tmp/pip-E6FneE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:49 INFO - Running setup.py (path:/tmp/pip-cQ8XO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:49 INFO - Running setup.py (path:/tmp/pip-HxxVwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:49 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)) 04:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:49 INFO - Running setup.py (path:/tmp/pip-kGCv_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:50 INFO - Running setup.py (path:/tmp/pip-pPExk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:50 INFO - Running setup.py (path:/tmp/pip-xhLTKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:50 INFO - Running setup.py (path:/tmp/pip-rPmxfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:50 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)) 04:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:50 INFO - Running setup.py (path:/tmp/pip-CP6MAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:50 INFO - Running setup.py (path:/tmp/pip-vKeyyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:50 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)) 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:50 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)) 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:50 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 04:39:50 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 04:39:50 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 04:39:50 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 04:39:50 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 04:39:50 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 04:39:57 INFO - Downloading blessings-1.6.tar.gz 04:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:57 INFO - Installing collected packages: blessings 04:39:57 INFO - Running setup.py install for blessings 04:39:57 INFO - Successfully installed blessings 04:39:57 INFO - Cleaning up... 04:39:57 INFO - Return code: 0 04:39:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:58 INFO - Reading from file tmpfile_stdout 04:39:58 INFO - Current package versions: 04:39:58 INFO - argparse == 1.2.1 04:39:58 INFO - blessings == 1.6 04:39:58 INFO - blobuploader == 1.2.4 04:39:58 INFO - docopt == 0.6.1 04:39:58 INFO - functools32 == 3.2.3-2 04:39:58 INFO - jsonschema == 2.5.1 04:39:58 INFO - manifestparser == 1.1 04:39:58 INFO - mozInstall == 1.12 04:39:58 INFO - mozcrash == 1.0 04:39:58 INFO - mozdebug == 0.1 04:39:58 INFO - mozdevice == 0.49 04:39:58 INFO - mozfile == 1.2 04:39:58 INFO - mozhttpd == 0.7 04:39:58 INFO - mozinfo == 0.9 04:39:58 INFO - mozleak == 0.1 04:39:58 INFO - mozlog == 3.4 04:39:58 INFO - moznetwork == 0.27 04:39:58 INFO - mozprocess == 0.25 04:39:58 INFO - mozprofile == 0.28 04:39:58 INFO - mozrunner == 6.13 04:39:58 INFO - mozscreenshot == 0.1 04:39:58 INFO - mozsystemmonitor == 0.3 04:39:58 INFO - moztest == 0.8 04:39:58 INFO - mozversion == 1.4 04:39:58 INFO - psutil == 3.1.1 04:39:58 INFO - requests == 1.2.3 04:39:58 INFO - wsgiref == 0.1.2 04:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:58 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')]} 04:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:58 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')]} 04:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:59 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 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:39:59 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 04:39:59 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 04:39:59 INFO - Using env: {'DISPLAY': ':0', 04:39:59 INFO - 'HOME': '/home/cltbld', 04:39:59 INFO - 'LANG': 'en_US.UTF-8', 04:39:59 INFO - 'LANGUAGE': 'en_US:en', 04:39:59 INFO - 'LOGNAME': 'cltbld', 04:39:59 INFO - 'MAIL': '/var/mail/cltbld', 04:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:59 INFO - 'MOZ_NO_REMOTE': '1', 04:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:59 INFO - 'NO_EM_RESTART': '1', 04:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:59 INFO - 'PWD': '/builds/slave/test', 04:39:59 INFO - 'SHELL': '/bin/bash', 04:39:59 INFO - 'SHLVL': '1', 04:39:59 INFO - 'TERM': 'linux', 04:39:59 INFO - 'TMOUT': '86400', 04:39:59 INFO - 'USER': 'cltbld', 04:39:59 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:59 INFO - '_': '/tools/buildbot/bin/python'} 04:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 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)) 04:39:59 INFO - Cleaning up... 04:39:59 INFO - Return code: 0 04:39:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:59 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')]} 04:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:59 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')]} 04:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e18b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', '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 04:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:40:00 INFO - Using env: {'DISPLAY': ':0', 04:40:00 INFO - 'HOME': '/home/cltbld', 04:40:00 INFO - 'LANG': 'en_US.UTF-8', 04:40:00 INFO - 'LANGUAGE': 'en_US:en', 04:40:00 INFO - 'LOGNAME': 'cltbld', 04:40:00 INFO - 'MAIL': '/var/mail/cltbld', 04:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:00 INFO - 'MOZ_NO_REMOTE': '1', 04:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:00 INFO - 'NO_EM_RESTART': '1', 04:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:00 INFO - 'PWD': '/builds/slave/test', 04:40:00 INFO - 'SHELL': '/bin/bash', 04:40:00 INFO - 'SHLVL': '1', 04:40:00 INFO - 'TERM': 'linux', 04:40:00 INFO - 'TMOUT': '86400', 04:40:00 INFO - 'USER': 'cltbld', 04:40:00 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:00 INFO - '_': '/tools/buildbot/bin/python'} 04:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:40:00 INFO - Cleaning up... 04:40:00 INFO - Return code: 0 04:40:00 INFO - Running post-action listener: _resource_record_post_action 04:40:00 INFO - Running post-action listener: _start_resource_monitoring 04:40:00 INFO - Starting resource monitoring. 04:40:00 INFO - [mozharness: 2017-03-28 11:40:00.702322Z] Finished create-virtualenv step (success) 04:40:00 INFO - [mozharness: 2017-03-28 11:40:00.702780Z] Running install step. 04:40:00 INFO - Running pre-action listener: _resource_record_pre_action 04:40:00 INFO - Running main action method: install 04:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:00 INFO - Reading from file tmpfile_stdout 04:40:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:01 INFO - Reading from file tmpfile_stdout 04:40:01 INFO - Output received: 04:40:01 INFO - Usage: mozinstall [options] installer 04:40:01 INFO - Options: 04:40:01 INFO - -h, --help show this help message and exit 04:40:01 INFO - -d DEST, --destination=DEST 04:40:01 INFO - Directory to install application into. [default: 04:40:01 INFO - "/builds/slave/test"] 04:40:01 INFO - --app=APP Application being installed. [default: firefox] 04:40:01 INFO - mkdir: /builds/slave/test/build/application 04:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:40:16 INFO - Reading from file tmpfile_stdout 04:40:16 INFO - Output received: 04:40:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:40:16 INFO - Running post-action listener: _resource_record_post_action 04:40:16 INFO - [mozharness: 2017-03-28 11:40:16.738819Z] Finished install step (success) 04:40:16 INFO - [mozharness: 2017-03-28 11:40:16.739093Z] Running run-tests step. 04:40:16 INFO - Running pre-action listener: _resource_record_pre_action 04:40:16 INFO - Running main action method: run_tests 04:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:16 INFO - Python 2.7.3 04:40:16 INFO - Return code: 0 04:40:16 INFO - grabbing minidump binary from tooltool 04:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:16 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 0x1e16290>, '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 0x1e16b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e17040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:16 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 04:40:16 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 04:40:16 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 04:40:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:16 INFO - Return code: 0 04:40:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:40:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:16 INFO - ENV: RUST_BACKTRACE is now 1 04:40:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:40:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:40:16 INFO - Using env: {'DISPLAY': ':0', 04:40:16 INFO - 'HOME': '/home/cltbld', 04:40:16 INFO - 'LANG': 'en_US.UTF-8', 04:40:16 INFO - 'LANGUAGE': 'en_US:en', 04:40:16 INFO - 'LOGNAME': 'cltbld', 04:40:16 INFO - 'MAIL': '/var/mail/cltbld', 04:40:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:16 INFO - 'MOZ_NO_REMOTE': '1', 04:40:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:16 INFO - 'NO_EM_RESTART': '1', 04:40:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:16 INFO - 'PWD': '/builds/slave/test', 04:40:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:16 INFO - 'RUST_BACKTRACE': '1', 04:40:16 INFO - 'SHELL': '/bin/bash', 04:40:16 INFO - 'SHLVL': '1', 04:40:16 INFO - 'TERM': 'linux', 04:40:16 INFO - 'TMOUT': '86400', 04:40:16 INFO - 'USER': 'cltbld', 04:40:16 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270', 04:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:16 INFO - '_': '/tools/buildbot/bin/python'} 04:40:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:40:17 INFO - mozversion application_buildid: 20170328110129 04:40:17 INFO - mozversion application_changeset: bf0f897261395ed2488f8fef72cf5353da1e105e 04:40:17 INFO - mozversion application_display_name: Nightly 04:40:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:17 INFO - mozversion application_name: Firefox 04:40:17 INFO - mozversion application_remotingname: firefox 04:40:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:40:17 INFO - mozversion application_vendor: Mozilla 04:40:17 INFO - mozversion application_version: 55.0a1 04:40:17 INFO - mozversion platform_buildid: 20170328110129 04:40:17 INFO - mozversion platform_changeset: bf0f897261395ed2488f8fef72cf5353da1e105e 04:40:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:40:17 INFO - mozversion platform_version: 55.0a1 04:40:17 INFO - using testdate: 1490701217 04:40:17 INFO - actual date: 1490701217 04:40:17 INFO - starting webserver on 'localhost:49481' 04:40:17 INFO - SUITE-START | Running 2 tests 04:40:17 INFO - TEST-START | dromaeo_css 04:40:17 INFO - operating with platform_type : linux_ 04:40:17 INFO - Initialising browser for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 4002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BUDdd/profile http://localhost:49481/getInfo.html) 04:40:21 INFO - PID 4002 | __metrics Screen width/height:1600/1200 04:40:21 INFO - PID 4002 | colorDepth:24 04:40:21 INFO - PID 4002 | Browser inner width/height: 1024/697 04:40:21 INFO - PID 4002 | __metrics 04:40:22 ERROR - PID 4002 | 1490701222378 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmp4BUDdd/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp4BUDdd/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp4BUDdd/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp4BUDdd/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:40:22 ERROR - PID 4002 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:40:23 INFO - TEST-INFO | 4002: exit 0 04:40:23 INFO - Browser initialized. 04:40:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:23 INFO - TEST-INFO | started process 4132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4BUDdd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:35 INFO - PID 4132 | RSS: Main: 156114944 04:40:35 INFO - PID 4132 | 04:43:42 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49481/tests/dromaeo/cssquery-ext.html) 04:43:43 INFO - PID 4132 | RSS: Main: 167436288 04:43:43 INFO - PID 4132 | 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | A coding exception was thrown and uncaught in a Task. 04:45:23 INFO - PID 4132 | 04:45:23 ERROR - PID 4132 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:23 INFO - PID 4132 | Full stack: 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | A coding exception was thrown and uncaught in a Task. 04:45:23 INFO - PID 4132 | 04:45:23 ERROR - PID 4132 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:23 INFO - PID 4132 | Full stack: 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | A coding exception was thrown and uncaught in a Task. 04:45:23 INFO - PID 4132 | 04:45:23 ERROR - PID 4132 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:23 INFO - PID 4132 | Full stack: 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | ************************* 04:45:23 INFO - PID 4132 | A coding exception was thrown and uncaught in a Task. 04:45:23 INFO - PID 4132 | 04:45:23 ERROR - PID 4132 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:23 INFO - PID 4132 | Full stack: 04:45:23 INFO - PID 4132 | ************************* 04:46:46 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-ext.html (next: http://localhost:49481/tests/dromaeo/cssquery-jquery.html) 04:46:46 INFO - PID 4132 | RSS: Main: 160337920 04:46:46 INFO - PID 4132 | 04:49:48 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49481/tests/dromaeo/cssquery-mootools.html) 04:49:49 INFO - PID 4132 | RSS: Main: 169541632 04:49:49 INFO - PID 4132 | 04:52:51 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49481/tests/dromaeo/cssquery-prototype.html) 04:52:52 INFO - PID 4132 | RSS: Main: 160784384 04:52:52 INFO - PID 4132 | 04:55:54 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49481/tests/dromaeo/cssquery-yui.html) 04:55:55 INFO - PID 4132 | RSS: Main: 169218048 04:55:55 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | Cycle 1(1): loaded http://localhost:49481/tests/dromaeo/cssquery-yui.html (next: http://localhost:49481/tests/dromaeo/cssquery-dojo.html) 04:58:58 INFO - PID 4132 | RSS: Main: 162635776 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | __start_tp_report 04:58:58 INFO - PID 4132 | _x_x_mozilla_page_load 04:58:58 INFO - PID 4132 | _x_x_mozilla_page_load_details 04:58:58 INFO - PID 4132 | |i|pagename|runs| 04:58:58 INFO - PID 4132 | |0;dojo.html;2678.571428571429;2718.4970780405615;2729.072115480736;2745.450909818037;2749.1065403743783;5105.157648987913;5218.608604354675;5218.947810521899;5256.500632439922;5270.7364631768405;5138.922916156261;5176.042432150046;5225.8954820903555;5252.553532949694;5298.92051619226;4750.192467280562;4818.807247710105;4821.204501257288;4842.370491836056;4853.927191092136;4854.101991131634;4869.220924652056;4922.237053256733;4930.063287975291;4944.2089265717495;4653.674242803005;4686.390769199982;4692.788824502905;4821.252705830602;4839.467658557556;4695.1783437898575;4697.989932164601;4698.177818881716;4710.387649605564;4711.151992641323;4624.560666736655;4626.190416677102;4670.229412146991;4676.415448068991;4677.204875171229;5072.594192464594;5093.465186155475;5153.484651534854;5154.896902061975;5176.50823171798;5630.943690563083;5656.123300888327;5671.517920976722;5699.829005129853;5703.914441283384;5675.631083979528;5687.516561092312;5716.371199168088;5727.083666613322;5742.6841523716175;5141.074606570815;5159.74201289934;5207.427183009866;5215.087359712035;5235.528802407725;5762.567807414461;5808.680522571215;5814;5828.921649494857;5866.6186697864505;5303.946960530346;5361.624686272002;5433.0763770159165;5518.834434966958;5560.971220324253;5658.971705141448;5667.149927510906;5673.489385955201;5675.8864822704145;5697.6296540724725;5483.259759932438;5497.47773961473;5535.142052981794;5543.168524721244;5548.72256387179;5561.721913904288;5575.107982722745;5597.916031259534;5599.860003499945;5613.663180209201;4754.477007529169;4769.42766867978;4774;4774.045190961821;4823.3729615149805;3948.861789837342;3955.584663610337;3974.105826189142;4021.638052575224;4045.7167998239843;4885.511448855157;4887.242477416006;4911.533404326583;4923.187674033744;4959.231319145466;5697.971510142423;5711.657300561979;5714.771409143671;5726.312842458931;5761.827145185651;4752.097101550694;4807.062622788592;4813.133635945564;4878.170710979142;4891.241857512091;4970.453250142481;5007.048660754518;5022.372203474566;5026.396832380138;5029.094762942632;5161.993411284763;5191.844244672666;5203.479652034766;5206.219067139959;5208.5312321891215;5558.610897237317;5593.552515798808;5604.439556044363;5605.915911261252;5606.6636001840025;5212;5223.425423203368;5226.712530810842;5226.947730522646;5269.235960785588;5484.753186106555;5573.693446860299;5582.804601838916;5586.86032849182;5587.161925711176;5526.944730552643;5650.434956504317;5665.263515742927;5695.743691533974;5748.338941021836;5426;5433.375161856437;5435.320584926884;5446;5458.099413596712;5294.655847369909;5411.080116380146;5452.482014208644;5466.070767969375;5476.863078423071;5300.01949639318;5303.098473259478;5319.228711836685;5325.786968521371;5339.385970613429;5507.311586051744;5532.778688852401;5544.445555444423;5560.110382338807;5561.749721262472;5155.793768249228;5216.843494695166;5344.599155063308;5413.458654134555;5441.918371224356 04:58:58 INFO - PID 4132 | |1;ext.html;651.4397618048478;708.2740191303913;718.7232915327597;1191.493615213534;1213.0780606738876;34046.48930266045;35136.47295290573;35200.9518905326;35223.2955340893;35353.646463535355;32348.19129521763;32573.511397329;32580.67419325806;32775.836120819426;32777.50833737496;6908.51640385172;7047.43620510358;7145.642717864112;7473.290037446434;7490.063742032246;6598.47212223021;6615.801525954229;6669.43309818666;6670.466362690973;6672.966635166842;6585.6048637081685;6633.568818026813;6637.46900247979;6648.4681225501845;6650.800475985729;6618;6625.834354141137;6629.668516574152;6636.137302150738;6637.336266373324;7386.593737344444;7427.368673662745;7450.664720087609;7469.1410487794055;7470;33994.6600533994;34101;34185.31629367424;34208.48687269693;34365.31269374624;2639.0855957391564;2640.973590264092;2654.283343497245;2692.4322036008784;2705.7700095491905;23959.520809583886;24017.77989916775;24514.264572062868;24617.38456538583;24687.135950241835;2789.470000699881;2812.3672173760947;2819.57706344048;2828.8019838611303;2829.561417980196;107820.4608976958;109347.45326273318;115274.42362788216;151730;152381.23809380992;37060;37368.43947340792;37371;37387.06532336659;37447.43828842569;41537.92310384469;41558.584414156074;41580.792096039324;41587.58412415837;41689.58310416857;12303;12400.131990760741;12416.379181040911;12449.502019919102;12504.187227830162;9897.851532227023;9902.722373854054;9926.751831204278;9948.353357031914;9952.15406690425;12901.741965160832;12953.352332383343;12964.28696421687;13083.41124649393;13192.868071319355;5468.890622187534;5496.615236933376;5501.312335958005;5537.8061767837935;5551.555875530029;830.7050996896015;864.4683519635379;870.0038455967881;872.7599910024667;872.7643536245179;20075.29736459217;20624.07191676378;21207.893960530408;21219.893900530707;21438.142474301167;935.7239614313658;939.4780455661871;957.1577012229333;964.647903515226;985.7141428985514;10777.676669699922;10785.46072696362;11076.224664273423;11143.66569002915;11206.495707693173;193770;196064;196320;196864;225849;45397.319040214425;46056;46170.307445388346;46238;46483.767581161876;1205.5128842264867;1215.6960759810047;1223.5962132496254;1223.8286639870425;1234.5432190089546;23642.290731278088;24509.50980980406;25196.74803251944;25367.36581585475;25727.614085788355;30273.545896811123;30758.077257682304;30789.384212316076;30799.538006929466;30865.69134308718;228747;229875;229884;230042;230302;28673.283167920134;29512.704872951854;29581.85209073941;29622.851885740434;29644.407111858072;34455.827720861234;35151.29697406089;35672.28655426825;36223.456648149775;36325.636743632225;26989.190324290303;27150.72849271482;27229.183124506297;27389;28285.434291313646;26670.19989400321;26797.196084117506;27132.593011104454;27749.583756243268;27899.97800395948;29637.5554366689;29812;30216;30334.84832575823;30343.544846827757;26326;26410.471790564465;26463.206103816916;26930.192094237205;27656.446871062064;20004.799952000874;21564.78435215628;21591.568168636855;21676.566468670855;21754.564908702054 04:58:58 INFO - PID 4132 | |2;jquery.html;416.1718180820169;424.14118672379993;430.3995925683672;440.7641911577306;443.4124784660326;16835.32658693654;17011.31954721811;17400.129993500337;17587.208575614128;17777.111144442773;16797.83202167978;17090.949086109653;17266;18588;18668.626627467478;5300.814471493489;5656.377798442189;5776.971115144418;5835.270591176103;5849.444302791228;5713.885722285552;5783.624064435799;5825.30096388434;5828.766849326022;5840.240768700084;5545.805896793613;5612.663240205601;5658.91511627326;5659.349174844884;5726;5633.63381380211;5648.491635752782;5662.8301150965535;5726.713664316768;5729.570282228829;5009.123403404426;5154.793808247703;5180.896382072375;5208.5572726318305;5224.712640804754;20803.37589872306;21097.8945105275;21286.467838304012;21376.46558836026;21385.35843924669;1511.2368254031644;1549;1556.7197904377208;1564.0829852325444;1564.3351575580446;13492;13852.792208116887;14004.649883752885;14077.225752583603;14757.852421475862;1626.3169468823123;1644.7089035107504;1665.84174503422;1689.248284513392;1732.0473739443255;87107;88651.55674221652;90632.54683726605;91887;91899;10539;10968.561257549609;11041.723956901142;11198.10415166801;11199.584126841228;14431.927840360731;15028.549143525712;15078;15088.773668394982;15182;7351.742689005859;7358.889616655754;7530.887036694454;7531.924680753123;7580.317771400601;6693.732250709917;6826.941824017285;6939.895901561481;6954.47841411886;6979.197392299849;6928.688209030605;7019.333163349474;7060.505764596429;7064.328888755663;7136.750213742494;2093.2464312847364;2103.1061798735477;2117.6717608770664;2132.125828410375;2246.8539544929527;833.9992009588518;844.9788755281168;856.6016802186888;866.0949307973183;871.7036207689289;15982.520524384287;16500.059978407764;16928.83071169297;17180.742288865677;17235.827641723423;871.6077765005646;874.8950125984923;878.7302348106924;881.2685471059006;895.5298468304062;8788.472691638393;9226.677066302647;9337.066293370744;9347.626094956262;9462.243020558339;415543;416011;419994;421444;434936;93776.06223937673;95320;95369;95782;95828.0417195833;1072.367303291062;1075.93544387337;1089.128697042363;1089.8746644135867;1163.8836116388293;15017.324220410326;15779.921100394884;17085.57286067858;17540.649187015933;17691.292348305924;37639;38376;39200.80399597984;43654;45515;44078;45931;46318.76840615775;46377.84055398507;46735.53264467448;11055.336679799238;11200.21598488098;11204.943975280072;11360.204785664924;12118.333491657691;12976.675583110498;13243.536476223671;13360.198388096745;13507.189568625914;13588.86411135876;11216.495257713586;11303.208775385972;11343.659690209306;11448.484818183035;11734.41585385962;10593.52329145175;10654.147668186371;10697.090747286567;10771.46142692878;10955.780884382428;10557.63048293306;10650.520726567478;10728.678139655824;10786.083182929538;10990.560377584807;11823.704407389883;11875.109366797353;11892.345920974429;12002.699932501757;12345.629631111082;11183.944080279547;11353.48909299067;11611.88388116108;11665.766684666429;11868.584599538975 04:58:58 INFO - PID 4132 | |3;mootools.html;1228.5822820241117;1286.67189866584;1294.2501021252003;1299.3243513373052;1306.248906878545;9405.106514881083;9714.902850971497;9771.462569558671;9955.601775928953;10183.28716989811;9764.072413120743;9906.257030722689;9914.900850991487;9944.453055081967;9951.950240248807;2213.878236696985;2267.1498188179435;2272.0684519346987;2273.170292843117;2276.8520046197027;2181.0621432783896;2230.69885565449;2280.6122959096992;2284.3946354216146;2292.6904867842877;2207.4040009197506;2253.9323820285417;2256.0862850545473;2260.7513173550897;2273.54529094181;2123.819475344598;2165.4478108082417;2170.7612162662094;2173.6956826044366;2178.357384571555;1846.9907650461796;1906.2946709717355;2145.8605190662556;2186.2457452178974;2191.539776646906;9624.085711857362;9747.707568772948;9759.756006099904;9771.364861284064;9772.51137443132;5436.075867102602;5638.520725738317;5643.097104463307;5654.349749778787;5656.745446454878;3295.9011229663147;3297.505374193866;3371.2077661749468;3372.5952885653633;3372.9494057589154;973.3235401396032;974.1427543761445;1006.4112494190907;1023.6110278094351;1028.598846449885;14631.048981816148;14655.41378344865;14721.116732996055;14731.116133032052;14763.852361476354;4803.639727020487;4861.246506791453;5006.574441172468;5015.297858299841;5019.7490125494305;10874.836877446845;10912.181586381053;10917.454127293604;10940.781184376268;10974.396408197626;5586;5592.916106258409;5594.216809646653;5595.664260144405;5611.158326251013;5058.190689489737;5117.974410127926;5181.3782346118705;5216.7913283469;5300.814471493479;3832.616738326201;3944.723869329177;3971.0667993021616;3971.384435412516;3983.2431837951276;1139.3221033485063;1143.3082984794246;1160.7620437810228;1163.598558497317;1178.1752773058893;676.1480534526532;695.2838576266454;696.5228818259509;704.2992222738305;717.587387252332;5263.289455923401;5266.157414813688;5316.946830531722;5335.306410166653;5366.195070739421;532.1804421191399;538.4938158131343;538.6148903533992;543.9728013599383;559.97480113395;3367.5285460035616;3376.1728376547903;3430.2110514581286;3435.5018522314626;3504.2641045380246;12665.240085594894;13257.734845303039;13262.668433289246;13285.3357332133;13286.66783330405;12162.452689628988;12445.813312800316;13182.340882955814;13209.73580528384;13213.075084744169;9185.35702500832;9296.814063718823;9513.143817056498;9550;9620.13418792312;5443.020256353894;5704.2014118024335;5742.530711793968;5750.7987220447085;5921.14143449206;11171.944140279247;11639.47622357013;11673.12451566153;11902.226355286879;11931.880681193077;11622.128340374336;11635.127365447455;11765.235259708092;11790.469428875893;11949.701257468632;8171.5505647189975;8384.2873355763;8468.872966905625;8476.872846907178;8479.830403391774;9283.814323713354;9333.206677432223;9408.81182376335;9439.81120377575;9447;7909.485883417559;7977.162397948364;8046.476978996347;8065.677372905253;8171.264586187272;7807.18024607408;7914.24814642608;7932.127465978853;7969.8406031880195;8045.678172873254;6501.44737697301;6506.869862602627;6538.411542961157;6558.344165583403;6579.243387010555;5295.7087360195555;5312.123499622519;5403;5533.335999680065;5610.85972850682;4997.675151115312;5172.9741351293005;5223.634345595772;5260.552853007384;5297.390800057889 04:58:58 INFO - PID 4132 | |4;prototype.html;352.52409247515857;366.04488501738734;370.6312219341755;373.04128390037596;374.43460374834;5498.67007979521;5600.7434349894065;5605.803796867111;5618.971905140468;5692.288463942007;5483.341998960131;5499.615026948115;5523.558115350772;5525.475079867416;5539.639923404976;4109.855960190456;4217.493900731916;4394.956050439503;4397.296432570789;4411.16187924295;4221.936670949938;4240.830366785325;4253.724257522226;4258.5954334338185;4258.829646814139;4190.182914331706;4197.622214000739;4200.264953633117;4219.725717828332;4224.767637779921;4098.511394418327;4193.748375097489;4213.620774130312;4214.7471151731;4249.617534421902;3612.7832330060282;3648.543932008499;3656.3601369760186;3665.5784584772828;3670.6512881276235;5373.796743335214;5374.301340825707;5381.4349493303425;5399.1091469907815;5405.7567409466665;4832.903341933177;4839.637027222972;4851.248056551205;4863.392075990501;4879.804807807684;5632.605717599769;5769.307683078057;5798.855028624276;5807.651540907559;5815.44753248445;4013;4015.4980627421573;4016.6585840203616;4027.3958906164016;4030.6573941215033;5816.080693371177;5897.911531327033;6031.366706495799;6102.542309326774;6195.287541932646;4087.509498860156;4107.424960505532;4113.341865301538;4123.814428350732;4126.649234815014;4149.25313443583;4169.082801783603;4169.249535083653;4174.749515029108;4176.248275310473;4577.633789296849;4774.212254977959;4826.686265392738;4843.951560484421;4858.8299409521205;5782;5789.378973887318;5797.623154494944;5813.331466881278;5823.88352232953;1423.750843602386;1427.6859090999963;1435.2034620785564;1437.9209143496998;1440.2150827798876;901.531203774047;961.3558915526614;961.5528779117744;969.8836139663144;971.6356366362614;5072.873178170576;5087.414947281036;5091.676164197335;5109.131447653907;5131.10205714006;5992.550558708114;5994.340622531518;6011.27864656244;6025.276966764016;6048.939510604838;4939.456659767423;5106.617003724736;5114.5652619527755;5137.486251374833;5147.176451767774;3175.825329606894;3193.25967347796;3198.7441004719567;3213.3412650406613;3216.212028053142;5550.888982220333;5583.720813959286;5598.664080155122;5603.10350343943;5620.85947851307;5845.269341332333;6153.753849845956;6171.475424588871;6180.381961803783;6213.875722485615;5610.438956104438;5624.240727501899;5624.3250809903075;5641.097424412156;5644.8306550803545;5833;5993.130996005642;6020.8795824084145;6068.666223357758;6082.300535438481;5878.823635290948;5888.234529511136;5890.911636325544;5892.1161825726485;5906.793262235801;5385.596080294072;5529.806456773994;5545.556355491632;5563.248961390161;5632.662040277596;4395.25280702275;4481.462224533077;4510.909781804411;4519.954800452085;4530.478994915627;5872.148538461814;6067.878642427038;6113.23584551931;6114.6636934969;6126.938730612636;5833.649981001154;5857.765689372377;5885.735141918538;5886.323072846678;5889.99740088372;5824.708764561839;5847.532197424111;5862.882742345044;5864.296284445893;5912.911306330495;5473.808416705396;5715.599908006566;5760.366359700513;5780.132980053026;5781.392953739797;5867.442592953663;5887.468388592946;5909.9066672665695;5910.143029260819;5929.620116533534;5536.889262214814;5656.830295091154;5725.141228815544;5736.282964629421;5760.539156867524 04:58:58 INFO - PID 4132 | |5;yui.html;692.3180667042959;701.6147090289355;704.654719187598;706.3325157725948;751.1399447632459;12663.366831658415;12867.613971580868;13079.215247085182;13286.734265314688;13820.894328453725;13375;13511.594652160426;13656.180629162258;13770.449182032708;13815.240161791098;846.2975730143996;871.1245198575455;875.1598465473154;875.4922145155795;876.9473831570094;827.3009307135491;857.0187135729586;864.6714248585529;869.7695110795644;870.6517393042802;922.1009515722151;924.5931790012373;926.2034650200821;929.5352323838081;930.2650905784423;912.9452232866049;915.9542022898895;917.5504003038529;918.5085979001236;919.0855099176296;675.3921470676381;677.6543962579071;680.0377465885766;680.1633990192042;680.9148856392951;13820.930895345458;13845;13849.099808512414;13998.440062397493;14430.855691443161;13667;14166.504172354022;14180.503682371067;14209.78685319721;14300.856991430057;10522.684319470429;10524.158067354594;10595;10629.893701062967;10637.787244255149;2669.4394177222807;2703.5268827955224;2724.5913113033007;2733.1390611957368;2760.5721113227482;66406.33593664049;66730.66634666844;67317;67568.66215668939;67939;10450.477476126163;10709.518071686793;10782.299150555189;10862.185336099667;10938.671839844817;21744.34766956994;21875.890620546794;21978.670319945213;22163.44591385196;22412.439689007904;6581.736730530821;6582.078509008743;6602.372774586503;6701.195856497252;6844.315568443116;3255.137388592025;3274.787138836016;3301.405746965569;3326.567546218976;3355.3289342131184;3389.74576906733;3458.360203362386;3464.359093567698;3886.553046399644;4065.288574499451;719.8128486593419;726.7529040126277;736.1203361982487;737.1412304665005;753.3596443023387;516.1380494574071;529.4731741916818;551.1732401397903;555.4484851180338;558.8822355289421;8434.15658434164;8930.258460375646;8988.415752976036;9016.819663606691;9079.364444488954;542.9592780541396;553.1840535210532;561.8454924895605;562.2578196780211;568.0797108683959;4120.979395103065;4242.384854196124;4272.273713468718;4298;4364.956350436519;61665.38334616686;63373.683131584046;64022.6798866012;65688.67155664192;66075.00887486692;55671.44328556744;56225;56495.71752141213;56606;56999.43000570024;49657;50150.74924625354;50673.49326506688;50698.746506267235;50863.74568127136;8231.506109633201;8618.82762344737;8637.438566493158;8697.913020869963;8826.867596985921;25868.189226753948;26559.468810624065;26643.60034599521;26762.197134086007;27054;32107.35785284328;32250.516242256854;32769.180770480925;32914;33193.336133276716;10430.322029068086;10735.141188704729;10744.73138171552;10816.783664326827;11303.43482825839;11683.766324673628;11779.411029448665;11803.173777835813;11924.642260732191;12654.87345126537;11590.188686791844;11618.419079046183;11713.824292635447;11756.70608234801;11932.463039163433;11329.943350283196;11393.658190254306;11631.418429078682;11684.415779210836;11831.290122592673;12080.456379463121;12357.826006529365;12560.371981401076;12576.245425274512;12788.744225115632;8592.880015441606;8910.127948203966;8929.642814287616;9074.45553266806;9080.545972701471;9222.962889264696;9989.950050249703;10613.893861061599;10631.149508039493;10787.67636970892 04:58:58 INFO - PID 4132 | __end_tp_report 04:58:58 INFO - PID 4132 | __start_cc_report 04:58:58 INFO - PID 4132 | _x_x_mozilla_cycle_collect,379 04:58:58 INFO - PID 4132 | __end_cc_report 04:58:58 INFO - PID 4132 | __startTimestamp1490702338766__endTimestamp 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | ------- Summary: start ------- 04:58:58 INFO - PID 4132 | Number of tests: 6 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#0] dojo.html Cycles:165 Average:5158.58 Median:5252.55 stddev:590.87 (11.2%) stddev-sans-first:559.74 04:58:58 INFO - PID 4132 | Values: 2678.6 2718.5 2729.1 2745.5 2749.1 5105.2 5218.6 5218.9 5256.5 5270.7 5138.9 5176.0 5225.9 5252.6 5298.9 4750.2 4818.8 4821.2 4842.4 4853.9 4854.1 4869.2 4922.2 4930.1 4944.2 4653.7 4686.4 4692.8 4821.3 4839.5 4695.2 4698.0 4698.2 4710.4 4711.2 4624.6 4626.2 4670.2 4676.4 4677.2 5072.6 5093.5 5153.5 5154.9 5176.5 5630.9 5656.1 5671.5 5699.8 5703.9 5675.6 5687.5 5716.4 5727.1 5742.7 5141.1 5159.7 5207.4 5215.1 5235.5 5762.6 5808.7 5814.0 5828.9 5866.6 5303.9 5361.6 5433.1 5518.8 5561.0 5659.0 5667.1 5673.5 5675.9 5697.6 5483.3 5497.5 5535.1 5543.2 5548.7 5561.7 5575.1 5597.9 5599.9 5613.7 4754.5 4769.4 4774.0 4774.0 4823.4 3948.9 3955.6 3974.1 4021.6 4045.7 4885.5 4887.2 4911.5 4923.2 4959.2 5698.0 5711.7 5714.8 5726.3 5761.8 4752.1 4807.1 4813.1 4878.2 4891.2 4970.5 5007.0 5022.4 5026.4 5029.1 5162.0 5191.8 5203.5 5206.2 5208.5 5558.6 5593.6 5604.4 5605.9 5606.7 5212.0 5223.4 5226.7 5226.9 5269.2 5484.8 5573.7 5582.8 5586.9 5587.2 5526.9 5650.4 5665.3 5695.7 5748.3 5426.0 5433.4 5435.3 5446.0 5458.1 5294.7 5411.1 5452.5 5466.1 5476.9 5300.0 5303.1 5319.2 5325.8 5339.4 5507.3 5532.8 5544.4 5560.1 5561.7 5155.8 5216.8 5344.6 5413.5 5441.9 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#1] ext.html Cycles:180 Average:32780.44 Median:30304.20 stddev:49977.19 (164.9%) stddev-sans-first:50059.17 04:58:58 INFO - PID 4132 | Values: 651.4 708.3 718.7 1191.5 1213.1 34046.5 35136.5 35201.0 35223.3 35353.6 32348.2 32573.5 32580.7 32775.8 32777.5 6908.5 7047.4 7145.6 7473.3 7490.1 6598.5 6615.8 6669.4 6670.5 6673.0 6585.6 6633.6 6637.5 6648.5 6650.8 6618.0 6625.8 6629.7 6636.1 6637.3 7386.6 7427.4 7450.7 7469.1 7470.0 33994.7 34101.0 34185.3 34208.5 34365.3 2639.1 2641.0 2654.3 2692.4 2705.8 23959.5 24017.8 24514.3 24617.4 24687.1 2789.5 2812.4 2819.6 2828.8 2829.6 107820.5 109347.5 115274.4 151730.0 152381.2 37060.0 37368.4 37371.0 37387.1 37447.4 41537.9 41558.6 41580.8 41587.6 41689.6 12303.0 12400.1 12416.4 12449.5 12504.2 9897.9 9902.7 9926.8 9948.4 9952.2 12901.7 12953.4 12964.3 13083.4 13192.9 5468.9 5496.6 5501.3 5537.8 5551.6 830.7 864.5 870.0 872.8 872.8 20075.3 20624.1 21207.9 21219.9 21438.1 935.7 939.5 957.2 964.6 985.7 10777.7 10785.5 11076.2 11143.7 11206.5 193770.0 196064.0 196320.0 196864.0 225849.0 45397.3 46056.0 46170.3 46238.0 46483.8 1205.5 1215.7 1223.6 1223.8 1234.5 23642.3 24509.5 25196.7 25367.4 25727.6 30273.5 30758.1 30789.4 30799.5 30865.7 228747.0 229875.0 229884.0 230042.0 230302.0 28673.3 29512.7 29581.9 29622.9 29644.4 34455.8 35151.3 35672.3 36223.5 36325.6 26989.2 27150.7 27229.2 27389.0 28285.4 26670.2 26797.2 27132.6 27749.6 27900.0 29637.6 29812.0 30216.0 30334.8 30343.5 26326.0 26410.5 26463.2 26930.2 27656.4 20004.8 21564.8 21591.6 21676.6 21754.6 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#2] jquery.html Cycles:180 Average:26986.46 Median:11709.30 stddev:70124.81 (598.9%) stddev-sans-first:70293.15 04:58:58 INFO - PID 4132 | Values: 416.2 424.1 430.4 440.8 443.4 16835.3 17011.3 17400.1 17587.2 17777.1 16797.8 17090.9 17266.0 18588.0 18668.6 5300.8 5656.4 5777.0 5835.3 5849.4 5713.9 5783.6 5825.3 5828.8 5840.2 5545.8 5612.7 5658.9 5659.3 5726.0 5633.6 5648.5 5662.8 5726.7 5729.6 5009.1 5154.8 5180.9 5208.6 5224.7 20803.4 21097.9 21286.5 21376.5 21385.4 1511.2 1549.0 1556.7 1564.1 1564.3 13492.0 13852.8 14004.6 14077.2 14757.9 1626.3 1644.7 1665.8 1689.2 1732.0 87107.0 88651.6 90632.5 91887.0 91899.0 10539.0 10968.6 11041.7 11198.1 11199.6 14431.9 15028.5 15078.0 15088.8 15182.0 7351.7 7358.9 7530.9 7531.9 7580.3 6693.7 6826.9 6939.9 6954.5 6979.2 6928.7 7019.3 7060.5 7064.3 7136.8 2093.2 2103.1 2117.7 2132.1 2246.9 834.0 845.0 856.6 866.1 871.7 15982.5 16500.1 16928.8 17180.7 17235.8 871.6 874.9 878.7 881.3 895.5 8788.5 9226.7 9337.1 9347.6 9462.2 415543.0 416011.0 419994.0 421444.0 434936.0 93776.1 95320.0 95369.0 95782.0 95828.0 1072.4 1075.9 1089.1 1089.9 1163.9 15017.3 15779.9 17085.6 17540.6 17691.3 37639.0 38376.0 39200.8 43654.0 45515.0 44078.0 45931.0 46318.8 46377.8 46735.5 11055.3 11200.2 11204.9 11360.2 12118.3 12976.7 13243.5 13360.2 13507.2 13588.9 11216.5 11303.2 11343.7 11448.5 11734.4 10593.5 10654.1 10697.1 10771.5 10955.8 10557.6 10650.5 10728.7 10786.1 10990.6 11823.7 11875.1 11892.3 12002.7 12345.6 11183.9 11353.5 11611.9 11665.8 11868.6 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#3] mootools.html Cycles:180 Average:6208.90 Median:5088.08 stddev:3974.13 (78.1%) stddev-sans-first:3967.65 04:58:58 INFO - PID 4132 | Values: 1228.6 1286.7 1294.3 1299.3 1306.2 9405.1 9714.9 9771.5 9955.6 10183.3 9764.1 9906.3 9914.9 9944.5 9952.0 2213.9 2267.1 2272.1 2273.2 2276.9 2181.1 2230.7 2280.6 2284.4 2292.7 2207.4 2253.9 2256.1 2260.8 2273.5 2123.8 2165.4 2170.8 2173.7 2178.4 1847.0 1906.3 2145.9 2186.2 2191.5 9624.1 9747.7 9759.8 9771.4 9772.5 5436.1 5638.5 5643.1 5654.3 5656.7 3295.9 3297.5 3371.2 3372.6 3372.9 973.3 974.1 1006.4 1023.6 1028.6 14631.0 14655.4 14721.1 14731.1 14763.9 4803.6 4861.2 5006.6 5015.3 5019.7 10874.8 10912.2 10917.5 10940.8 10974.4 5586.0 5592.9 5594.2 5595.7 5611.2 5058.2 5118.0 5181.4 5216.8 5300.8 3832.6 3944.7 3971.1 3971.4 3983.2 1139.3 1143.3 1160.8 1163.6 1178.2 676.1 695.3 696.5 704.3 717.6 5263.3 5266.2 5316.9 5335.3 5366.2 532.2 538.5 538.6 544.0 560.0 3367.5 3376.2 3430.2 3435.5 3504.3 12665.2 13257.7 13262.7 13285.3 13286.7 12162.5 12445.8 13182.3 13209.7 13213.1 9185.4 9296.8 9513.1 9550.0 9620.1 5443.0 5704.2 5742.5 5750.8 5921.1 11171.9 11639.5 11673.1 11902.2 11931.9 11622.1 11635.1 11765.2 11790.5 11949.7 8171.6 8384.3 8468.9 8476.9 8479.8 9283.8 9333.2 9408.8 9439.8 9447.0 7909.5 7977.2 8046.5 8065.7 8171.3 7807.2 7914.2 7932.1 7969.8 8045.7 6501.4 6506.9 6538.4 6558.3 6579.2 5295.7 5312.1 5403.0 5533.3 5610.9 4997.7 5173.0 5223.6 5260.6 5297.4 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#4] prototype.html Cycles:180 Average:4808.05 Median:5524.52 stddev:1418.72 (25.7%) stddev-sans-first:1382.72 04:58:58 INFO - PID 4132 | Values: 352.5 366.0 370.6 373.0 374.4 5498.7 5600.7 5605.8 5619.0 5692.3 5483.3 5499.6 5523.6 5525.5 5539.6 4109.9 4217.5 4395.0 4397.3 4411.2 4221.9 4240.8 4253.7 4258.6 4258.8 4190.2 4197.6 4200.3 4219.7 4224.8 4098.5 4193.7 4213.6 4214.7 4249.6 3612.8 3648.5 3656.4 3665.6 3670.7 5373.8 5374.3 5381.4 5399.1 5405.8 4832.9 4839.6 4851.2 4863.4 4879.8 5632.6 5769.3 5798.9 5807.7 5815.4 4013.0 4015.5 4016.7 4027.4 4030.7 5816.1 5897.9 6031.4 6102.5 6195.3 4087.5 4107.4 4113.3 4123.8 4126.6 4149.3 4169.1 4169.2 4174.7 4176.2 4577.6 4774.2 4826.7 4844.0 4858.8 5782.0 5789.4 5797.6 5813.3 5823.9 1423.8 1427.7 1435.2 1437.9 1440.2 901.5 961.4 961.6 969.9 971.6 5072.9 5087.4 5091.7 5109.1 5131.1 5992.6 5994.3 6011.3 6025.3 6048.9 4939.5 5106.6 5114.6 5137.5 5147.2 3175.8 3193.3 3198.7 3213.3 3216.2 5550.9 5583.7 5598.7 5603.1 5620.9 5845.3 6153.8 6171.5 6180.4 6213.9 5610.4 5624.2 5624.3 5641.1 5644.8 5833.0 5993.1 6020.9 6068.7 6082.3 5878.8 5888.2 5890.9 5892.1 5906.8 5385.6 5529.8 5545.6 5563.2 5632.7 4395.3 4481.5 4510.9 4520.0 4530.5 5872.1 6067.9 6113.2 6114.7 6126.9 5833.6 5857.8 5885.7 5886.3 5890.0 5824.7 5847.5 5862.9 5864.3 5912.9 5473.8 5715.6 5760.4 5780.1 5781.4 5867.4 5887.5 5909.9 5910.1 5929.6 5536.9 5656.8 5725.1 5736.3 5760.5 04:58:58 INFO - PID 4132 | 04:58:58 INFO - PID 4132 | [#5] yui.html Cycles:180 Average:14394.80 Median:4285.14 stddev:17736.05 (413.9%) stddev-sans-first:17755.95 04:58:58 INFO - PID 4132 | Values: 692.3 701.6 704.7 706.3 751.1 12663.4 12867.6 13079.2 13286.7 13820.9 13375.0 13511.6 13656.2 13770.4 13815.2 846.3 871.1 875.2 875.5 876.9 827.3 857.0 864.7 869.8 870.7 922.1 924.6 926.2 929.5 930.3 912.9 916.0 917.6 918.5 919.1 675.4 677.7 680.0 680.2 680.9 13820.9 13845.0 13849.1 13998.4 14430.9 13667.0 14166.5 14180.5 14209.8 14300.9 10522.7 10524.2 10595.0 10629.9 10637.8 2669.4 2703.5 2724.6 2733.1 2760.6 66406.3 66730.7 67317.0 67568.7 67939.0 10450.5 10709.5 10782.3 10862.2 10938.7 21744.3 21875.9 21978.7 22163.4 22412.4 6581.7 6582.1 6602.4 6701.2 6844.3 3255.1 3274.8 3301.4 3326.6 3355.3 3389.7 3458.4 3464.4 3886.6 4065.3 719.8 726.8 736.1 737.1 753.4 516.1 529.5 551.2 555.4 558.9 8434.2 8930.3 8988.4 9016.8 9079.4 543.0 553.2 561.8 562.3 568.1 4121.0 4242.4 4272.3 4298.0 4365.0 61665.4 63373.7 64022.7 65688.7 66075.0 55671.4 56225.0 56495.7 56606.0 56999.4 49657.0 50150.7 50673.5 50698.7 50863.7 8231.5 8618.8 8637.4 8697.9 8826.9 25868.2 26559.5 26643.6 26762.2 27054.0 32107.4 32250.5 32769.2 32914.0 33193.3 10430.3 10735.1 10744.7 10816.8 11303.4 11683.8 11779.4 11803.2 11924.6 12654.9 11590.2 11618.4 11713.8 11756.7 11932.5 11329.9 11393.7 11631.4 11684.4 11831.3 12080.5 12357.8 12560.4 12576.2 12788.7 8592.9 8910.1 8929.6 9074.5 9080.5 9223.0 9990.0 10613.9 10631.1 10787.7 04:58:58 INFO - PID 4132 | -------- Summary: end -------- 04:58:58 INFO - PID 4132 | 04:58:59 INFO - TEST-INFO | 4132: exit 0 04:58:59 INFO - TEST-OK | dromaeo_css | took 1122593ms 04:58:59 INFO - TEST-START | kraken 04:58:59 INFO - operating with platform_type : linux_ 04:58:59 INFO - Initialising browser for kraken test... 04:58:59 INFO - TEST-INFO | started process 4509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRddTt1/profile http://localhost:49481/getInfo.html) 04:59:04 INFO - PID 4509 | __metrics Screen width/height:1600/1200 04:59:04 INFO - PID 4509 | colorDepth:24 04:59:04 INFO - PID 4509 | Browser inner width/height: 1024/697 04:59:04 INFO - PID 4509 | __metrics 04:59:05 ERROR - PID 4509 | 1490702345137 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpRddTt1/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpRddTt1/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpRddTt1/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpRddTt1/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:59:05 ERROR - PID 4509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:59:06 INFO - TEST-INFO | 4509: exit 0 04:59:06 INFO - Browser initialized. 04:59:06 INFO - Running cycle 1/1 for kraken test... 04:59:06 INFO - TEST-INFO | started process 4640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRddTt1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:18 INFO - PID 4640 | RSS: Main: 155688960 04:59:18 INFO - PID 4640 | 04:59:20 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:21 INFO - PID 4640 | RSS: Main: 163176448 04:59:21 INFO - PID 4640 | 04:59:24 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-dft) 04:59:25 INFO - PID 4640 | RSS: Main: 161828864 04:59:25 INFO - PID 4640 | 04:59:28 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-fft) 04:59:28 INFO - PID 4640 | RSS: Main: 158085120 04:59:28 INFO - PID 4640 | 04:59:31 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49481/tests/kraken/driver.html?testName=audio-oscillator) 04:59:31 INFO - PID 4640 | RSS: Main: 159019008 04:59:31 INFO - PID 4640 | 04:59:33 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:34 INFO - PID 4640 | RSS: Main: 159252480 04:59:34 INFO - PID 4640 | 04:59:37 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:38 INFO - PID 4640 | RSS: Main: 163291136 04:59:38 INFO - PID 4640 | 04:59:41 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49481/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:42 INFO - PID 4640 | RSS: Main: 161419264 04:59:42 INFO - PID 4640 | 04:59:45 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49481/tests/kraken/driver.html?testName=json-parse-financial) 04:59:46 INFO - PID 4640 | RSS: Main: 163115008 04:59:46 INFO - PID 4640 | 04:59:47 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:48 INFO - PID 4640 | RSS: Main: 162590720 04:59:48 INFO - PID 4640 | 04:59:50 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:51 INFO - PID 4640 | RSS: Main: 162353152 04:59:51 INFO - PID 4640 | 04:59:53 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:53 INFO - PID 4640 | RSS: Main: 163381248 04:59:53 INFO - PID 4640 | 04:59:56 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:57 INFO - PID 4640 | RSS: Main: 163508224 04:59:57 INFO - PID 4640 | 05:00:00 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:01 INFO - PID 4640 | RSS: Main: 163393536 05:00:01 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | Cycle 1(1): loaded http://localhost:49481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49481/tests/kraken/driver.html?testName=ai-astar) 05:00:03 INFO - PID 4640 | RSS: Main: 165249024 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | __start_tp_report 05:00:03 INFO - PID 4640 | _x_x_mozilla_page_load 05:00:03 INFO - PID 4640 | _x_x_mozilla_page_load_details 05:00:03 INFO - PID 4640 | |i|pagename|runs| 05:00:03 INFO - PID 4640 | |0;ai-astar;105;112;112;113;117;112;111;111;112;113 05:00:03 INFO - PID 4640 | |1;audio-beat-detection;152;125;127;174;127;126;124;126;144;126 05:00:03 INFO - PID 4640 | |2;audio-dft;165;166;163;170;173;168;169;165;166;166 05:00:03 INFO - PID 4640 | |3;audio-fft;75;77;76;109;76;77;76;80;104;77 05:00:03 INFO - PID 4640 | |4;audio-oscillator;85;85;105;85;85;85;100;85;84;105 05:00:03 INFO - PID 4640 | |5;imaging-gaussian-blur;114;115;114;114;114;114;115;115;114;114 05:00:03 INFO - PID 4640 | |6;imaging-darkroom;151;151;153;151;151;153;151;152;151;154 05:00:03 INFO - PID 4640 | |7;imaging-desaturate;96;96;95;95;95;95;96;95;96;96 05:00:03 INFO - PID 4640 | |8;json-parse-financial;69;69;69;72;69;70;71;70;70;69 05:00:03 INFO - PID 4640 | |9;json-stringify-tinderbox;55;54;55;58;56;56;55;55;55;56 05:00:03 INFO - PID 4640 | |10;stanford-crypto-aes;85;82;84;85;84;90;91;84;82;83 05:00:03 INFO - PID 4640 | |11;stanford-crypto-ccm;136;149;136;140;133;156;140;141;194;141 05:00:03 INFO - PID 4640 | |12;stanford-crypto-pbkdf2;189;196;197;198;196;196;193;198;199;196 05:00:03 INFO - PID 4640 | |13;stanford-crypto-sha256-iterative;72;74;73;72;72;70;71;72;71;77 05:00:03 INFO - PID 4640 | __end_tp_report 05:00:03 INFO - PID 4640 | __start_cc_report 05:00:03 INFO - PID 4640 | _x_x_mozilla_cycle_collect,891 05:00:03 INFO - PID 4640 | __end_cc_report 05:00:03 INFO - PID 4640 | __startTimestamp1490702403417__endTimestamp 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | ------- Summary: start ------- 05:00:03 INFO - PID 4640 | Number of tests: 14 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:1.81 05:00:03 INFO - PID 4640 | Values: 105.0 112.0 112.0 113.0 117.0 112.0 111.0 111.0 112.0 113.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:127.00 stddev:16.61 (13.1%) stddev-sans-first:16.45 05:00:03 INFO - PID 4640 | Values: 152.0 125.0 127.0 174.0 127.0 126.0 124.0 126.0 144.0 126.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#2] audio-dft Cycles:10 Average:167.10 Median:167.00 stddev:2.92 (1.8%) stddev-sans-first:3.00 05:00:03 INFO - PID 4640 | Values: 165.0 166.0 163.0 170.0 173.0 168.0 169.0 165.0 166.0 166.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:12.67 (16.6%) stddev-sans-first:13.13 05:00:03 INFO - PID 4640 | Values: 75.0 77.0 76.0 109.0 76.0 77.0 76.0 80.0 104.0 77.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:85.00 stddev:9.03 (10.6%) stddev-sans-first:9.37 05:00:03 INFO - PID 4640 | Values: 85.0 85.0 105.0 85.0 85.0 85.0 100.0 85.0 84.0 105.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:00:03 INFO - PID 4640 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 05:00:03 INFO - PID 4640 | Values: 151.0 151.0 153.0 151.0 151.0 153.0 151.0 152.0 151.0 154.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:00:03 INFO - PID 4640 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 05:00:03 INFO - PID 4640 | Values: 69.0 69.0 69.0 72.0 69.0 70.0 71.0 70.0 70.0 69.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:1.08 (1.9%) stddev-sans-first:1.13 05:00:03 INFO - PID 4640 | Values: 55.0 54.0 55.0 58.0 56.0 56.0 55.0 55.0 55.0 56.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:3.09 (3.7%) stddev-sans-first:3.28 05:00:03 INFO - PID 4640 | Values: 85.0 82.0 84.0 85.0 84.0 90.0 91.0 84.0 82.0 83.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:141.00 stddev:17.95 (12.7%) stddev-sans-first:18.63 05:00:03 INFO - PID 4640 | Values: 136.0 149.0 136.0 140.0 133.0 156.0 140.0 141.0 194.0 141.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.80 Median:196.50 stddev:2.90 (1.5%) stddev-sans-first:1.74 05:00:03 INFO - PID 4640 | Values: 189.0 196.0 197.0 198.0 196.0 196.0 193.0 198.0 199.0 196.0 05:00:03 INFO - PID 4640 | 05:00:03 INFO - PID 4640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.00 stddev:1.96 (2.7%) stddev-sans-first:2.07 05:00:03 INFO - PID 4640 | Values: 72.0 74.0 73.0 72.0 72.0 70.0 71.0 72.0 71.0 77.0 05:00:03 INFO - PID 4640 | -------- Summary: end -------- 05:00:03 INFO - PID 4640 | 05:00:04 INFO - TEST-INFO | 4640: exit 0 05:00:04 INFO - TEST-OK | kraken | took 64968ms 05:00:04 INFO - SUITE-END | took 1187s 05:00:05 INFO - Completed test suite (00:19:48) 05:00:05 INFO - javascript benchmark 05:00:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6662.13608082441, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.571428571429, 2718.4970780405615, 2729.072115480736, 2745.450909818037, 2749.1065403743783, 5105.157648987913, 5218.608604354675, 5218.947810521899, 5256.500632439922, 5270.7364631768405, 5138.922916156261, 5176.042432150046, 5225.8954820903555, 5252.553532949694, 5298.92051619226, 4750.192467280562, 4818.807247710105, 4821.204501257288, 4842.370491836056, 4853.927191092136, 4854.101991131634, 4869.220924652056, 4922.237053256733, 4930.063287975291, 4944.2089265717495, 4653.674242803005, 4686.390769199982, 4692.788824502905, 4821.252705830602, 4839.467658557556, 4695.1783437898575, 4697.989932164601, 4698.177818881716, 4710.387649605564, 4711.151992641323, 4624.560666736655, 4626.190416677102, 4670.229412146991, 4676.415448068991, 4677.204875171229, 5072.594192464594, 5093.465186155475, 5153.484651534854, 5154.896902061975, 5176.50823171798, 5630.943690563083, 5656.123300888327, 5671.517920976722, 5699.829005129853, 5703.914441283384, 5675.631083979528, 5687.516561092312, 5716.371199168088, 5727.083666613322, 5742.6841523716175, 5141.074606570815, 5159.74201289934, 5207.427183009866, 5215.087359712035, 5235.528802407725, 5762.567807414461, 5808.680522571215, 5814.0, 5828.921649494857, 5866.6186697864505, 5303.946960530346, 5361.624686272002, 5433.0763770159165, 5518.834434966958, 5560.971220324253, 5658.971705141448, 5667.149927510906, 5673.489385955201, 5675.8864822704145, 5697.6296540724725, 5483.259759932438, 5497.47773961473, 5535.142052981794, 5543.168524721244, 5548.72256387179, 5561.721913904288, 5575.107982722745, 5597.916031259534, 5599.860003499945, 5613.663180209201, 4754.477007529169, 4769.42766867978, 4774.0, 4774.045190961821, 4823.3729615149805, 3948.861789837342, 3955.584663610337, 3974.105826189142, 4021.638052575224, 4045.7167998239843, 4885.511448855157, 4887.242477416006, 4911.533404326583, 4923.187674033744, 4959.231319145466, 5697.971510142423, 5711.657300561979, 5714.771409143671, 5726.312842458931, 5761.827145185651, 4752.097101550694, 4807.062622788592, 4813.133635945564, 4878.170710979142, 4891.241857512091, 4970.453250142481, 5007.048660754518, 5022.372203474566, 5026.396832380138, 5029.094762942632, 5161.993411284763, 5191.844244672666, 5203.479652034766, 5206.219067139959, 5208.5312321891215, 5558.610897237317, 5593.552515798808, 5604.439556044363, 5605.915911261252, 5606.6636001840025, 5212.0, 5223.425423203368, 5226.712530810842, 5226.947730522646, 5269.235960785588, 5484.753186106555, 5573.693446860299, 5582.804601838916, 5586.86032849182, 5587.161925711176, 5526.944730552643, 5650.434956504317, 5665.263515742927, 5695.743691533974, 5748.338941021836, 5426.0, 5433.375161856437, 5435.320584926884, 5446.0, 5458.099413596712, 5294.655847369909, 5411.080116380146, 5452.482014208644, 5466.070767969375, 5476.863078423071, 5300.01949639318, 5303.098473259478, 5319.228711836685, 5325.786968521371, 5339.385970613429, 5507.311586051744, 5532.778688852401, 5544.445555444423, 5560.110382338807, 5561.749721262472, 5155.793768249228, 5216.843494695166, 5344.599155063308, 5413.458654134555, 5441.918371224356], "value": 5116.26998882168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.4397618048478, 708.2740191303913, 718.7232915327597, 1191.493615213534, 1213.0780606738876, 34046.48930266045, 35136.47295290573, 35200.9518905326, 35223.2955340893, 35353.646463535355, 32348.19129521763, 32573.511397329, 32580.67419325806, 32775.836120819426, 32777.50833737496, 6908.51640385172, 7047.43620510358, 7145.642717864112, 7473.290037446434, 7490.063742032246, 6598.47212223021, 6615.801525954229, 6669.43309818666, 6670.466362690973, 6672.966635166842, 6585.6048637081685, 6633.568818026813, 6637.46900247979, 6648.4681225501845, 6650.800475985729, 6618.0, 6625.834354141137, 6629.668516574152, 6636.137302150738, 6637.336266373324, 7386.593737344444, 7427.368673662745, 7450.664720087609, 7469.1410487794055, 7470.0, 33994.6600533994, 34101.0, 34185.31629367424, 34208.48687269693, 34365.31269374624, 2639.0855957391564, 2640.973590264092, 2654.283343497245, 2692.4322036008784, 2705.7700095491905, 23959.520809583886, 24017.77989916775, 24514.264572062868, 24617.38456538583, 24687.135950241835, 2789.470000699881, 2812.3672173760947, 2819.57706344048, 2828.8019838611303, 2829.561417980196, 107820.4608976958, 109347.45326273318, 115274.42362788216, 151730.0, 152381.23809380992, 37060.0, 37368.43947340792, 37371.0, 37387.06532336659, 37447.43828842569, 41537.92310384469, 41558.584414156074, 41580.792096039324, 41587.58412415837, 41689.58310416857, 12303.0, 12400.131990760741, 12416.379181040911, 12449.502019919102, 12504.187227830162, 9897.851532227023, 9902.722373854054, 9926.751831204278, 9948.353357031914, 9952.15406690425, 12901.741965160832, 12953.352332383343, 12964.28696421687, 13083.41124649393, 13192.868071319355, 5468.890622187534, 5496.615236933376, 5501.312335958005, 5537.8061767837935, 5551.555875530029, 830.7050996896015, 864.4683519635379, 870.0038455967881, 872.7599910024667, 872.7643536245179, 20075.29736459217, 20624.07191676378, 21207.893960530408, 21219.893900530707, 21438.142474301167, 935.7239614313658, 939.4780455661871, 957.1577012229333, 964.647903515226, 985.7141428985514, 10777.676669699922, 10785.46072696362, 11076.224664273423, 11143.66569002915, 11206.495707693173, 193770.0, 196064.0, 196320.0, 196864.0, 225849.0, 45397.319040214425, 46056.0, 46170.307445388346, 46238.0, 46483.767581161876, 1205.5128842264867, 1215.6960759810047, 1223.5962132496254, 1223.8286639870425, 1234.5432190089546, 23642.290731278088, 24509.50980980406, 25196.74803251944, 25367.36581585475, 25727.614085788355, 30273.545896811123, 30758.077257682304, 30789.384212316076, 30799.538006929466, 30865.69134308718, 228747.0, 229875.0, 229884.0, 230042.0, 230302.0, 28673.283167920134, 29512.704872951854, 29581.85209073941, 29622.851885740434, 29644.407111858072, 34455.827720861234, 35151.29697406089, 35672.28655426825, 36223.456648149775, 36325.636743632225, 26989.190324290303, 27150.72849271482, 27229.183124506297, 27389.0, 28285.434291313646, 26670.19989400321, 26797.196084117506, 27132.593011104454, 27749.583756243268, 27899.97800395948, 29637.5554366689, 29812.0, 30216.0, 30334.84832575823, 30343.544846827757, 26326.0, 26410.471790564465, 26463.206103816916, 26930.192094237205, 27656.446871062064, 20004.799952000874, 21564.78435215628, 21591.568168636855, 21676.566468670855, 21754.564908702054], "value": 14630.858188739974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.1718180820169, 424.14118672379993, 430.3995925683672, 440.7641911577306, 443.4124784660326, 16835.32658693654, 17011.31954721811, 17400.129993500337, 17587.208575614128, 17777.111144442773, 16797.83202167978, 17090.949086109653, 17266.0, 18588.0, 18668.626627467478, 5300.814471493489, 5656.377798442189, 5776.971115144418, 5835.270591176103, 5849.444302791228, 5713.885722285552, 5783.624064435799, 5825.30096388434, 5828.766849326022, 5840.240768700084, 5545.805896793613, 5612.663240205601, 5658.91511627326, 5659.349174844884, 5726.0, 5633.63381380211, 5648.491635752782, 5662.8301150965535, 5726.713664316768, 5729.570282228829, 5009.123403404426, 5154.793808247703, 5180.896382072375, 5208.5572726318305, 5224.712640804754, 20803.37589872306, 21097.8945105275, 21286.467838304012, 21376.46558836026, 21385.35843924669, 1511.2368254031644, 1549.0, 1556.7197904377208, 1564.0829852325444, 1564.3351575580446, 13492.0, 13852.792208116887, 14004.649883752885, 14077.225752583603, 14757.852421475862, 1626.3169468823123, 1644.7089035107504, 1665.84174503422, 1689.248284513392, 1732.0473739443255, 87107.0, 88651.55674221652, 90632.54683726605, 91887.0, 91899.0, 10539.0, 10968.561257549609, 11041.723956901142, 11198.10415166801, 11199.584126841228, 14431.927840360731, 15028.549143525712, 15078.0, 15088.773668394982, 15182.0, 7351.742689005859, 7358.889616655754, 7530.887036694454, 7531.924680753123, 7580.317771400601, 6693.732250709917, 6826.941824017285, 6939.895901561481, 6954.47841411886, 6979.197392299849, 6928.688209030605, 7019.333163349474, 7060.505764596429, 7064.328888755663, 7136.750213742494, 2093.2464312847364, 2103.1061798735477, 2117.6717608770664, 2132.125828410375, 2246.8539544929527, 833.9992009588518, 844.9788755281168, 856.6016802186888, 866.0949307973183, 871.7036207689289, 15982.520524384287, 16500.059978407764, 16928.83071169297, 17180.742288865677, 17235.827641723423, 871.6077765005646, 874.8950125984923, 878.7302348106924, 881.2685471059006, 895.5298468304062, 8788.472691638393, 9226.677066302647, 9337.066293370744, 9347.626094956262, 9462.243020558339, 415543.0, 416011.0, 419994.0, 421444.0, 434936.0, 93776.06223937673, 95320.0, 95369.0, 95782.0, 95828.0417195833, 1072.367303291062, 1075.93544387337, 1089.128697042363, 1089.8746644135867, 1163.8836116388293, 15017.324220410326, 15779.921100394884, 17085.57286067858, 17540.649187015933, 17691.292348305924, 37639.0, 38376.0, 39200.80399597984, 43654.0, 45515.0, 44078.0, 45931.0, 46318.76840615775, 46377.84055398507, 46735.53264467448, 11055.336679799238, 11200.21598488098, 11204.943975280072, 11360.204785664924, 12118.333491657691, 12976.675583110498, 13243.536476223671, 13360.198388096745, 13507.189568625914, 13588.86411135876, 11216.495257713586, 11303.208775385972, 11343.659690209306, 11448.484818183035, 11734.41585385962, 10593.52329145175, 10654.147668186371, 10697.090747286567, 10771.46142692878, 10955.780884382428, 10557.63048293306, 10650.520726567478, 10728.678139655824, 10786.083182929538, 10990.560377584807, 11823.704407389883, 11875.109366797353, 11892.345920974429, 12002.699932501757, 12345.629631111082, 11183.944080279547, 11353.48909299067, 11611.88388116108, 11665.766684666429, 11868.584599538975], "value": 9056.492380080692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1228.5822820241117, 1286.67189866584, 1294.2501021252003, 1299.3243513373052, 1306.248906878545, 9405.106514881083, 9714.902850971497, 9771.462569558671, 9955.601775928953, 10183.28716989811, 9764.072413120743, 9906.257030722689, 9914.900850991487, 9944.453055081967, 9951.950240248807, 2213.878236696985, 2267.1498188179435, 2272.0684519346987, 2273.170292843117, 2276.8520046197027, 2181.0621432783896, 2230.69885565449, 2280.6122959096992, 2284.3946354216146, 2292.6904867842877, 2207.4040009197506, 2253.9323820285417, 2256.0862850545473, 2260.7513173550897, 2273.54529094181, 2123.819475344598, 2165.4478108082417, 2170.7612162662094, 2173.6956826044366, 2178.357384571555, 1846.9907650461796, 1906.2946709717355, 2145.8605190662556, 2186.2457452178974, 2191.539776646906, 9624.085711857362, 9747.707568772948, 9759.756006099904, 9771.364861284064, 9772.51137443132, 5436.075867102602, 5638.520725738317, 5643.097104463307, 5654.349749778787, 5656.745446454878, 3295.9011229663147, 3297.505374193866, 3371.2077661749468, 3372.5952885653633, 3372.9494057589154, 973.3235401396032, 974.1427543761445, 1006.4112494190907, 1023.6110278094351, 1028.598846449885, 14631.048981816148, 14655.41378344865, 14721.116732996055, 14731.116133032052, 14763.852361476354, 4803.639727020487, 4861.246506791453, 5006.574441172468, 5015.297858299841, 5019.7490125494305, 10874.836877446845, 10912.181586381053, 10917.454127293604, 10940.781184376268, 10974.396408197626, 5586.0, 5592.916106258409, 5594.216809646653, 5595.664260144405, 5611.158326251013, 5058.190689489737, 5117.974410127926, 5181.3782346118705, 5216.7913283469, 5300.814471493479, 3832.616738326201, 3944.723869329177, 3971.0667993021616, 3971.384435412516, 3983.2431837951276, 1139.3221033485063, 1143.3082984794246, 1160.7620437810228, 1163.598558497317, 1178.1752773058893, 676.1480534526532, 695.2838576266454, 696.5228818259509, 704.2992222738305, 717.587387252332, 5263.289455923401, 5266.157414813688, 5316.946830531722, 5335.306410166653, 5366.195070739421, 532.1804421191399, 538.4938158131343, 538.6148903533992, 543.9728013599383, 559.97480113395, 3367.5285460035616, 3376.1728376547903, 3430.2110514581286, 3435.5018522314626, 3504.2641045380246, 12665.240085594894, 13257.734845303039, 13262.668433289246, 13285.3357332133, 13286.66783330405, 12162.452689628988, 12445.813312800316, 13182.340882955814, 13209.73580528384, 13213.075084744169, 9185.35702500832, 9296.814063718823, 9513.143817056498, 9550.0, 9620.13418792312, 5443.020256353894, 5704.2014118024335, 5742.530711793968, 5750.7987220447085, 5921.14143449206, 11171.944140279247, 11639.47622357013, 11673.12451566153, 11902.226355286879, 11931.880681193077, 11622.128340374336, 11635.127365447455, 11765.235259708092, 11790.469428875893, 11949.701257468632, 8171.5505647189975, 8384.2873355763, 8468.872966905625, 8476.872846907178, 8479.830403391774, 9283.814323713354, 9333.206677432223, 9408.81182376335, 9439.81120377575, 9447.0, 7909.485883417559, 7977.162397948364, 8046.476978996347, 8065.677372905253, 8171.264586187272, 7807.18024607408, 7914.24814642608, 7932.127465978853, 7969.8406031880195, 8045.678172873254, 6501.44737697301, 6506.869862602627, 6538.411542961157, 6558.344165583403, 6579.243387010555, 5295.7087360195555, 5312.123499622519, 5403.0, 5533.335999680065, 5610.85972850682, 4997.675151115312, 5172.9741351293005, 5223.634345595772, 5260.552853007384, 5297.390800057889], "value": 4637.495181293379, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.52409247515857, 366.04488501738734, 370.6312219341755, 373.04128390037596, 374.43460374834, 5498.67007979521, 5600.7434349894065, 5605.803796867111, 5618.971905140468, 5692.288463942007, 5483.341998960131, 5499.615026948115, 5523.558115350772, 5525.475079867416, 5539.639923404976, 4109.855960190456, 4217.493900731916, 4394.956050439503, 4397.296432570789, 4411.16187924295, 4221.936670949938, 4240.830366785325, 4253.724257522226, 4258.5954334338185, 4258.829646814139, 4190.182914331706, 4197.622214000739, 4200.264953633117, 4219.725717828332, 4224.767637779921, 4098.511394418327, 4193.748375097489, 4213.620774130312, 4214.7471151731, 4249.617534421902, 3612.7832330060282, 3648.543932008499, 3656.3601369760186, 3665.5784584772828, 3670.6512881276235, 5373.796743335214, 5374.301340825707, 5381.4349493303425, 5399.1091469907815, 5405.7567409466665, 4832.903341933177, 4839.637027222972, 4851.248056551205, 4863.392075990501, 4879.804807807684, 5632.605717599769, 5769.307683078057, 5798.855028624276, 5807.651540907559, 5815.44753248445, 4013.0, 4015.4980627421573, 4016.6585840203616, 4027.3958906164016, 4030.6573941215033, 5816.080693371177, 5897.911531327033, 6031.366706495799, 6102.542309326774, 6195.287541932646, 4087.509498860156, 4107.424960505532, 4113.341865301538, 4123.814428350732, 4126.649234815014, 4149.25313443583, 4169.082801783603, 4169.249535083653, 4174.749515029108, 4176.248275310473, 4577.633789296849, 4774.212254977959, 4826.686265392738, 4843.951560484421, 4858.8299409521205, 5782.0, 5789.378973887318, 5797.623154494944, 5813.331466881278, 5823.88352232953, 1423.750843602386, 1427.6859090999963, 1435.2034620785564, 1437.9209143496998, 1440.2150827798876, 901.531203774047, 961.3558915526614, 961.5528779117744, 969.8836139663144, 971.6356366362614, 5072.873178170576, 5087.414947281036, 5091.676164197335, 5109.131447653907, 5131.10205714006, 5992.550558708114, 5994.340622531518, 6011.27864656244, 6025.276966764016, 6048.939510604838, 4939.456659767423, 5106.617003724736, 5114.5652619527755, 5137.486251374833, 5147.176451767774, 3175.825329606894, 3193.25967347796, 3198.7441004719567, 3213.3412650406613, 3216.212028053142, 5550.888982220333, 5583.720813959286, 5598.664080155122, 5603.10350343943, 5620.85947851307, 5845.269341332333, 6153.753849845956, 6171.475424588871, 6180.381961803783, 6213.875722485615, 5610.438956104438, 5624.240727501899, 5624.3250809903075, 5641.097424412156, 5644.8306550803545, 5833.0, 5993.130996005642, 6020.8795824084145, 6068.666223357758, 6082.300535438481, 5878.823635290948, 5888.234529511136, 5890.911636325544, 5892.1161825726485, 5906.793262235801, 5385.596080294072, 5529.806456773994, 5545.556355491632, 5563.248961390161, 5632.662040277596, 4395.25280702275, 4481.462224533077, 4510.909781804411, 4519.954800452085, 4530.478994915627, 5872.148538461814, 6067.878642427038, 6113.23584551931, 6114.6636934969, 6126.938730612636, 5833.649981001154, 5857.765689372377, 5885.735141918538, 5886.323072846678, 5889.99740088372, 5824.708764561839, 5847.532197424111, 5862.882742345044, 5864.296284445893, 5912.911306330495, 5473.808416705396, 5715.599908006566, 5760.366359700513, 5780.132980053026, 5781.392953739797, 5867.442592953663, 5887.468388592946, 5909.9066672665695, 5910.143029260819, 5929.620116533534, 5536.889262214814, 5656.830295091154, 5725.141228815544, 5736.282964629421, 5760.539156867524], "value": 4361.517313954014, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.3180667042959, 701.6147090289355, 704.654719187598, 706.3325157725948, 751.1399447632459, 12663.366831658415, 12867.613971580868, 13079.215247085182, 13286.734265314688, 13820.894328453725, 13375.0, 13511.594652160426, 13656.180629162258, 13770.449182032708, 13815.240161791098, 846.2975730143996, 871.1245198575455, 875.1598465473154, 875.4922145155795, 876.9473831570094, 827.3009307135491, 857.0187135729586, 864.6714248585529, 869.7695110795644, 870.6517393042802, 922.1009515722151, 924.5931790012373, 926.2034650200821, 929.5352323838081, 930.2650905784423, 912.9452232866049, 915.9542022898895, 917.5504003038529, 918.5085979001236, 919.0855099176296, 675.3921470676381, 677.6543962579071, 680.0377465885766, 680.1633990192042, 680.9148856392951, 13820.930895345458, 13845.0, 13849.099808512414, 13998.440062397493, 14430.855691443161, 13667.0, 14166.504172354022, 14180.503682371067, 14209.78685319721, 14300.856991430057, 10522.684319470429, 10524.158067354594, 10595.0, 10629.893701062967, 10637.787244255149, 2669.4394177222807, 2703.5268827955224, 2724.5913113033007, 2733.1390611957368, 2760.5721113227482, 66406.33593664049, 66730.66634666844, 67317.0, 67568.66215668939, 67939.0, 10450.477476126163, 10709.518071686793, 10782.299150555189, 10862.185336099667, 10938.671839844817, 21744.34766956994, 21875.890620546794, 21978.670319945213, 22163.44591385196, 22412.439689007904, 6581.736730530821, 6582.078509008743, 6602.372774586503, 6701.195856497252, 6844.315568443116, 3255.137388592025, 3274.787138836016, 3301.405746965569, 3326.567546218976, 3355.3289342131184, 3389.74576906733, 3458.360203362386, 3464.359093567698, 3886.553046399644, 4065.288574499451, 719.8128486593419, 726.7529040126277, 736.1203361982487, 737.1412304665005, 753.3596443023387, 516.1380494574071, 529.4731741916818, 551.1732401397903, 555.4484851180338, 558.8822355289421, 8434.15658434164, 8930.258460375646, 8988.415752976036, 9016.819663606691, 9079.364444488954, 542.9592780541396, 553.1840535210532, 561.8454924895605, 562.2578196780211, 568.0797108683959, 4120.979395103065, 4242.384854196124, 4272.273713468718, 4298.0, 4364.956350436519, 61665.38334616686, 63373.683131584046, 64022.6798866012, 65688.67155664192, 66075.00887486692, 55671.44328556744, 56225.0, 56495.71752141213, 56606.0, 56999.43000570024, 49657.0, 50150.74924625354, 50673.49326506688, 50698.746506267235, 50863.74568127136, 8231.506109633201, 8618.82762344737, 8637.438566493158, 8697.913020869963, 8826.867596985921, 25868.189226753948, 26559.468810624065, 26643.60034599521, 26762.197134086007, 27054.0, 32107.35785284328, 32250.516242256854, 32769.180770480925, 32914.0, 33193.336133276716, 10430.322029068086, 10735.141188704729, 10744.73138171552, 10816.783664326827, 11303.43482825839, 11683.766324673628, 11779.411029448665, 11803.173777835813, 11924.642260732191, 12654.87345126537, 11590.188686791844, 11618.419079046183, 11713.824292635447, 11756.70608234801, 11932.463039163433, 11329.943350283196, 11393.658190254306, 11631.418429078682, 11684.415779210836, 11831.290122592673, 12080.456379463121, 12357.826006529365, 12560.371981401076, 12576.245425274512, 12788.744225115632, 8592.880015441606, 8910.127948203966, 8929.642814287616, 9074.45553266806, 9080.545972701471, 9222.962889264696, 9989.950050249703, 10613.893861061599, 10631.149508039493, 10787.67636970892], "value": 6375.935619501589, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 117.0, 112.0, 111.0, 111.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 127.0, 174.0, 127.0, 126.0, 124.0, 126.0, 144.0, 126.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 170.0, 173.0, 168.0, 169.0, 165.0, 166.0, 166.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 109.0, 76.0, 77.0, 76.0, 80.0, 104.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 85.0, 85.0, 85.0, 100.0, 85.0, 84.0, 105.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 153.0, 151.0, 151.0, 153.0, 151.0, 152.0, 151.0, 154.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 72.0, 69.0, 70.0, 71.0, 70.0, 70.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 58.0, 56.0, 56.0, 55.0, 55.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 85.0, 84.0, 90.0, 91.0, 84.0, 82.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 149.0, 136.0, 140.0, 133.0, 156.0, 140.0, 141.0, 194.0, 141.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 196.0, 197.0, 198.0, 196.0, 196.0, 193.0, 198.0, 199.0, 196.0], "value": 195.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 72.0, 72.0, 70.0, 71.0, 72.0, 71.0, 77.0], "value": 72.4, "unit": "score"}]}]} 05:00:05 INFO - Return code: 0 05:00:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:00:05 ERROR - # TBPL SUCCESS # 05:00:05 INFO - Running post-action listener: _resource_record_post_action 05:00:05 INFO - [mozharness: 2017-03-28 12:00:05.240481Z] Finished run-tests step (success) 05:00:05 INFO - Running post-run listener: _resource_record_post_run 05:00:05 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 430080; Write bytes: 258191360; Read time: 64; Write time: 116532 05:00:05 INFO - TinderboxPrint: CPU usage
13.3% 05:00:05 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 64 05:00:05 INFO - TinderboxPrint: I/O write bytes / time
258,191,360 / 116,532 05:00:05 INFO - TinderboxPrint: CPU idle
8,328.2 (86.7%) 05:00:05 INFO - TinderboxPrint: CPU user
1,221.9 (12.7%) 05:00:05 INFO - TinderboxPrint: Swap in / out
0 / 0 05:00:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 2723840; Read time: 0; Write time: 224 05:00:05 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 425984; Write bytes: 255021056; Read time: 52; Write time: 116304 05:00:05 INFO - Running post-run listener: _upload_blobber_files 05:00:05 INFO - Blob upload gear active. 05:00:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:00:05 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 05:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:00:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:07 INFO - (blobuploader) - INFO - Done attempting. 05:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:00:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:08 INFO - (blobuploader) - INFO - Done attempting. 05:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:11 INFO - (blobuploader) - INFO - Done attempting. 05:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:00:12 INFO - (blobuploader) - INFO - Done attempting. 05:00:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:00:12 INFO - Return code: 0 05:00:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:00:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:00:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdd83fbaa465d2461a288703276473553e0e692fb8e925b517bf7d1f37eae78b6c3e884327f706f3faacf62edae527ad7b27c7b64f42322b39ae449443e73a23", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5700948ff4c8603c1b45c941971a80c15ec51188ce3901094ca4ec16777f28c25b00c9cf351a19966ffcb924aef4f5fa163ba75a818fd176174cda37849663f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7ccf5a7826b3f36e5f7475de82fed073b1c69163efbac670b999a13279515977e2acc05054d851f07b5ec6ae89a600e8edd1b542774e845eda8a6ebe5ac4e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce5617160afab9849b213c2ab7c75b2f7d5a3b61ee7c9916622433bc39068a56403ac5d387fc5584d8de13dc3b9e49c936b0117930c04ddd52ced2c519885df"} 05:00:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:00:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:00:12 INFO - Contents: 05:00:12 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdd83fbaa465d2461a288703276473553e0e692fb8e925b517bf7d1f37eae78b6c3e884327f706f3faacf62edae527ad7b27c7b64f42322b39ae449443e73a23", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5700948ff4c8603c1b45c941971a80c15ec51188ce3901094ca4ec16777f28c25b00c9cf351a19966ffcb924aef4f5fa163ba75a818fd176174cda37849663f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7ccf5a7826b3f36e5f7475de82fed073b1c69163efbac670b999a13279515977e2acc05054d851f07b5ec6ae89a600e8edd1b542774e845eda8a6ebe5ac4e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce5617160afab9849b213c2ab7c75b2f7d5a3b61ee7c9916622433bc39068a56403ac5d387fc5584d8de13dc3b9e49c936b0117930c04ddd52ced2c519885df"} 05:00:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:00:12 INFO - Copying logs to upload dir... 05:00:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:00:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1348.658846 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2017-03-28 05:00:12.785630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 05:00:12.789250) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdd83fbaa465d2461a288703276473553e0e692fb8e925b517bf7d1f37eae78b6c3e884327f706f3faacf62edae527ad7b27c7b64f42322b39ae449443e73a23", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5700948ff4c8603c1b45c941971a80c15ec51188ce3901094ca4ec16777f28c25b00c9cf351a19966ffcb924aef4f5fa163ba75a818fd176174cda37849663f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7ccf5a7826b3f36e5f7475de82fed073b1c69163efbac670b999a13279515977e2acc05054d851f07b5ec6ae89a600e8edd1b542774e845eda8a6ebe5ac4e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce5617160afab9849b213c2ab7c75b2f7d5a3b61ee7c9916622433bc39068a56403ac5d387fc5584d8de13dc3b9e49c936b0117930c04ddd52ced2c519885df"} build_url:https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/d69pDPH3QQKu4zQ0a1sOOQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdd83fbaa465d2461a288703276473553e0e692fb8e925b517bf7d1f37eae78b6c3e884327f706f3faacf62edae527ad7b27c7b64f42322b39ae449443e73a23", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5700948ff4c8603c1b45c941971a80c15ec51188ce3901094ca4ec16777f28c25b00c9cf351a19966ffcb924aef4f5fa163ba75a818fd176174cda37849663f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7ccf5a7826b3f36e5f7475de82fed073b1c69163efbac670b999a13279515977e2acc05054d851f07b5ec6ae89a600e8edd1b542774e845eda8a6ebe5ac4e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ce5617160afab9849b213c2ab7c75b2f7d5a3b61ee7c9916622433bc39068a56403ac5d387fc5584d8de13dc3b9e49c936b0117930c04ddd52ced2c519885df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 05:00:12.814671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 05:00:12.815025) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1490701049.198428-1714542270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 05:00:12.900717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 05:00:12.901039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 05:00:12.901362) ========= ========= Total master_lag: 0.16 =========