builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1490959737.35 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.351108) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.351541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.351810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.366740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.367152) ========= 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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 04:28:57-- 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% 224M=0s 2017-03-31 04:28:57 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118185 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.533761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.534103) ========= 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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019671 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.584071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.584485) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --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 03d602fd723ad6ff4588c04855884ffa1dee9410 --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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 04:28:58,019 truncating revision to first 12 chars 2017-03-31 04:28:58,019 Setting DEBUG logging. 2017-03-31 04:28:58,019 attempt 1/10 2017-03-31 04:28:58,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 04:28:58,465 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.765619 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.384366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.384684) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.385057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.385357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.394392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-31 04:28:58.394789) ========= /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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:58 INFO - MultiFileLogger online at 20170331 04:28:58 in /builds/slave/test 04:28:58 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:28:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:58 INFO - {'append_to_log': False, 04:28:58 INFO - 'base_work_dir': '/builds/slave/test', 04:28:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:28:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:58 INFO - 'branch': 'Firefox-Non-PGO', 04:28:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:58 INFO - 'config_files': ('talos/linux_config.py',), 04:28:58 INFO - 'default_actions': ('clobber', 04:28:58 INFO - 'read-buildbot-config', 04:28:58 INFO - 'download-and-extract', 04:28:58 INFO - 'populate-webroot', 04:28:58 INFO - 'create-virtualenv', 04:28:58 INFO - 'install', 04:28:58 INFO - 'run-tests'), 04:28:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:58 INFO - 'download_minidump_stackwalk': True, 04:28:58 INFO - 'download_symbols': 'ondemand', 04:28:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:58 INFO - 'gecko_profile': False, 04:28:58 INFO - 'gecko_profile_interval': 0, 04:28:58 INFO - 'installer_path': 'installer.exe', 04:28:58 INFO - 'log_level': 'info', 04:28:58 INFO - 'log_name': 'talos', 04:28:58 INFO - 'log_to_console': True, 04:28:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:58 INFO - 'opt_config_files': (), 04:28:58 INFO - 'pip_index': False, 04:28:58 INFO - 'suite': 'dromaeojs-e10s', 04:28:58 INFO - 'system_bits': '32', 04:28:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:58 INFO - 'title': 'talos-linux64-ix-021', 04:28:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:58 INFO - 'use_talos_json': True, 04:28:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:58 INFO - 'work_dir': 'build'} 04:28:58 INFO - [mozharness: 2017-03-31 11:28:58.901561Z] Running clobber step. 04:28:58 INFO - Running pre-action listener: _resource_record_pre_action 04:28:58 INFO - Running main action method: clobber 04:28:58 INFO - rmtree: /builds/slave/test/build 04:28:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:28:59 INFO - Running post-action listener: _resource_record_post_action 04:28:59 INFO - [mozharness: 2017-03-31 11:28:59.829686Z] Finished clobber step (success) 04:28:59 INFO - [mozharness: 2017-03-31 11:28:59.829787Z] Running read-buildbot-config step. 04:28:59 INFO - Running pre-action listener: _resource_record_pre_action 04:28:59 INFO - Running main action method: read_buildbot_config 04:28:59 INFO - Using buildbot properties: 04:28:59 INFO - { 04:28:59 INFO - "project": "", 04:28:59 INFO - "product": "firefox", 04:28:59 INFO - "who": "cbook@mozilla.com", 04:28:59 INFO - "installer_path": "public/build/target.tar.bz2", 04:28:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:28:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:28:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:28:59 INFO - "stage_platform": "linux64", 04:28:59 INFO - "basedir": "/builds/slave/test", 04:28:59 INFO - "buildnumber": 495, 04:28:59 INFO - "platform": "ubuntu64_hw", 04:28:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:28:59 INFO - "slavebuilddir": "test", 04:28:59 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 04:28:59 INFO - "branch": "mozilla-central", 04:28:59 INFO - "script_repo_revision": "production", 04:28:59 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 04:28:59 INFO - "slavename": "talos-linux64-ix-021", 04:28:59 INFO - "repo_path": "mozilla-central" 04:28:59 INFO - } 04:28:59 INFO - Finding installer, test and symbols from parent task. 04:28:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:00 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 04:29:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 04:29:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 04:29:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 04:29:01 INFO - Running post-action listener: _resource_record_post_action 04:29:01 INFO - [mozharness: 2017-03-31 11:29:01.195372Z] Finished read-buildbot-config step (success) 04:29:01 INFO - [mozharness: 2017-03-31 11:29:01.195594Z] Running download-and-extract step. 04:29:01 INFO - Running pre-action listener: _resource_record_pre_action 04:29:01 INFO - Running main action method: download_and_extract 04:29:01 INFO - mkdir: /builds/slave/test/build/tests 04:29:01 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:29:01 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 04:29:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:29:01 INFO - Downloaded 986 bytes. 04:29:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:29:01 INFO - Using the following test package requirements: 04:29:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:29:01 INFO - u'common': [u'target.common.tests.zip'], 04:29:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:29:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:29:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:29:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:29:01 INFO - u'mozbase': [u'target.common.tests.zip'], 04:29:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:29:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:29:01 INFO - u'web-platform': [u'target.common.tests.zip', 04:29:01 INFO - u'target.web-platform.tests.zip'], 04:29:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:29:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:02 INFO - Expected file size: 58227794 04:29:02 INFO - Obtained file size: 58227794 04:29:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:29:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:13 INFO - Expected file size: 58227794 04:29:14 INFO - Obtained file size: 58227794 04:29:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 04:29:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:29:24 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 04:29:25 INFO - Expected file size: 14404152 04:29:25 INFO - Obtained file size: 14404152 04:29: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:29:25 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:29:26 INFO - Downloaded 62478421 bytes. 04:29:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:26 INFO - mkdir: /builds/slave/test/properties 04:29:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:26 INFO - Contents: 04:29:26 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:26 INFO - Running post-action listener: _resource_record_post_action 04:29:26 INFO - Running post-action listener: set_extra_try_arguments 04:29:26 INFO - [mozharness: 2017-03-31 11:29:26.896530Z] Finished download-and-extract step (success) 04:29:26 INFO - [mozharness: 2017-03-31 11:29:26.896627Z] Running populate-webroot step. 04:29:26 INFO - Running pre-action listener: _resource_record_pre_action 04:29:26 INFO - Running main action method: populate_webroot 04:29:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:26 INFO - '--tppagecycles', 04:29:26 INFO - '7'], 04:29:26 INFO - 'tests': ['tsvgm']}}, 04:29:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['damp', 'tps']}, 04:29:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'tests': ['damp', 'tps']}, 04:29:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['dromaeo_dom']}, 04:29:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['basic_compositor_video']}, 04:29:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:29:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['a11yr', 04:29:26 INFO - 'ts_paint', 04:29:26 INFO - 'tpaint', 04:29:26 INFO - 'sessionrestore', 04:29:26 INFO - 'sessionrestore_no_auto_restore', 04:29:26 INFO - 'tabpaint']}, 04:29:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['tsvgx', 04:29:26 INFO - 'tsvgr_opacity', 04:29:26 INFO - 'tart', 04:29:26 INFO - 'tscrollx', 04:29:26 INFO - 'cart', 04:29:26 INFO - 'tsvg_static']}, 04:29:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:26 INFO - 'tsvgr_opacity', 04:29:26 INFO - 'tart', 04:29:26 INFO - 'tscrollx', 04:29:26 INFO - 'cart', 04:29:26 INFO - 'tsvg_static']}, 04:29:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'talos_options': ['--disable-e10s'], 04:29:26 INFO - 'tests': ['tp5o']}, 04:29:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:29:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'talos_options': ['--disable-e10s', 04:29:26 INFO - '--xperf_path', 04:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:26 INFO - 'tests': ['tp5n']}, 04:29:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:29:26 INFO - 'talos_options': ['--xperf_path', 04:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:26 INFO - 'tests': ['tp5n']}}, 04:29:26 INFO - 'talos.zip': {'path': '', 04:29:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:26 INFO - Running post-action listener: _resource_record_post_action 04:29:26 INFO - [mozharness: 2017-03-31 11:29:26.909862Z] Finished populate-webroot step (success) 04:29:26 INFO - [mozharness: 2017-03-31 11:29:26.909952Z] Running create-virtualenv step. 04:29:26 INFO - Running pre-action listener: _resource_record_pre_action 04:29:26 INFO - Running main action method: create_virtualenv 04:29:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:26 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:29:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:27 INFO - Using real prefix '/usr' 04:29:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:29 INFO - Installing pip.................done. 04:29:29 INFO - Return code: 0 04:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:29:29 INFO - Reading from file tmpfile_stdout 04:29:29 INFO - Output received: 04:29:29 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:29:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29: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:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:29 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:29:29 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:29:29 INFO - Using env: {'DISPLAY': ':0', 04:29:29 INFO - 'HOME': '/home/cltbld', 04:29:29 INFO - 'LANG': 'en_US.UTF-8', 04:29:29 INFO - 'LANGUAGE': 'en_US:en', 04:29:29 INFO - 'LOGNAME': 'cltbld', 04:29:29 INFO - 'MAIL': '/var/mail/cltbld', 04:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:29 INFO - 'MOZ_NO_REMOTE': '1', 04:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:29 INFO - 'NO_EM_RESTART': '1', 04:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:29 INFO - 'PWD': '/builds/slave/test', 04:29:29 INFO - 'SHELL': '/bin/bash', 04:29:29 INFO - 'SHLVL': '1', 04:29:29 INFO - 'TERM': 'linux', 04:29:29 INFO - 'TMOUT': '86400', 04:29:29 INFO - 'USER': 'cltbld', 04:29:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:29 INFO - '_': '/tools/buildbot/bin/python'} 04:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:29 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:29:29 INFO - Cleaning up... 04:29:29 INFO - Return code: 0 04:29:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:29: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:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:29 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:29 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:29:29 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:29:29 INFO - Using env: {'DISPLAY': ':0', 04:29:29 INFO - 'HOME': '/home/cltbld', 04:29:29 INFO - 'LANG': 'en_US.UTF-8', 04:29:29 INFO - 'LANGUAGE': 'en_US:en', 04:29:29 INFO - 'LOGNAME': 'cltbld', 04:29:29 INFO - 'MAIL': '/var/mail/cltbld', 04:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:29 INFO - 'MOZ_NO_REMOTE': '1', 04:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:29 INFO - 'NO_EM_RESTART': '1', 04:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:29 INFO - 'PWD': '/builds/slave/test', 04:29:29 INFO - 'SHELL': '/bin/bash', 04:29:29 INFO - 'SHLVL': '1', 04:29:29 INFO - 'TERM': 'linux', 04:29:29 INFO - 'TMOUT': '86400', 04:29:29 INFO - 'USER': 'cltbld', 04:29:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:29 INFO - '_': '/tools/buildbot/bin/python'} 04:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:30 INFO - Downloading/unpacking psutil>=3.1.1 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:32 INFO - Installing collected packages: psutil 04:29:32 INFO - Running setup.py install for psutil 04:29:32 INFO - building 'psutil._psutil_linux' extension 04:29:32 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:29:32 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:29:32 INFO - building 'psutil._psutil_posix' extension 04:29:32 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:29:32 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:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:32 INFO - Successfully installed psutil 04:29:32 INFO - Cleaning up... 04:29:32 INFO - Return code: 0 04:29:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:29: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 mozsystemmonitor==0.3 04:29:32 INFO - Using env: {'DISPLAY': ':0', 04:29:32 INFO - 'HOME': '/home/cltbld', 04:29:32 INFO - 'LANG': 'en_US.UTF-8', 04:29:32 INFO - 'LANGUAGE': 'en_US:en', 04:29:32 INFO - 'LOGNAME': 'cltbld', 04:29:32 INFO - 'MAIL': '/var/mail/cltbld', 04:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:32 INFO - 'MOZ_NO_REMOTE': '1', 04:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:32 INFO - 'NO_EM_RESTART': '1', 04:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:32 INFO - 'PWD': '/builds/slave/test', 04:29:32 INFO - 'SHELL': '/bin/bash', 04:29:32 INFO - 'SHLVL': '1', 04:29:32 INFO - 'TERM': 'linux', 04:29:32 INFO - 'TMOUT': '86400', 04:29:32 INFO - 'USER': 'cltbld', 04:29:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:32 INFO - '_': '/tools/buildbot/bin/python'} 04:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:29:35 INFO - Installing collected packages: mozsystemmonitor 04:29:35 INFO - Running setup.py install for mozsystemmonitor 04:29:35 INFO - Successfully installed mozsystemmonitor 04:29:35 INFO - Cleaning up... 04:29:35 INFO - Return code: 0 04:29:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:29:35 INFO - Using env: {'DISPLAY': ':0', 04:29:35 INFO - 'HOME': '/home/cltbld', 04:29:35 INFO - 'LANG': 'en_US.UTF-8', 04:29:35 INFO - 'LANGUAGE': 'en_US:en', 04:29:35 INFO - 'LOGNAME': 'cltbld', 04:29:35 INFO - 'MAIL': '/var/mail/cltbld', 04:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:35 INFO - 'MOZ_NO_REMOTE': '1', 04:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:35 INFO - 'NO_EM_RESTART': '1', 04:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:35 INFO - 'PWD': '/builds/slave/test', 04:29:35 INFO - 'SHELL': '/bin/bash', 04:29:35 INFO - 'SHLVL': '1', 04:29:35 INFO - 'TERM': 'linux', 04:29:35 INFO - 'TMOUT': '86400', 04:29:35 INFO - 'USER': 'cltbld', 04:29:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:35 INFO - '_': '/tools/buildbot/bin/python'} 04:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:35 INFO - Downloading/unpacking jsonschema==2.5.1 04:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 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:29:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:37 INFO - warning: no files found matching '*.txt' 04:29:37 INFO - no previously-included directories found matching 'build' 04:29:37 INFO - no previously-included directories found matching 'dist' 04:29:37 INFO - no previously-included directories found matching '.git*' 04:29:37 INFO - Installing collected packages: jsonschema, functools32 04:29:37 INFO - Running setup.py install for functools32 04:29:37 INFO - warning: no files found matching '*.txt' 04:29:37 INFO - no previously-included directories found matching 'build' 04:29:37 INFO - no previously-included directories found matching 'dist' 04:29:37 INFO - no previously-included directories found matching '.git*' 04:29:37 INFO - Successfully installed jsonschema functools32 04:29:37 INFO - Cleaning up... 04:29:37 INFO - Return code: 0 04:29:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:38 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:38 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:29:38 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:29:38 INFO - Using env: {'DISPLAY': ':0', 04:29:38 INFO - 'HOME': '/home/cltbld', 04:29:38 INFO - 'LANG': 'en_US.UTF-8', 04:29:38 INFO - 'LANGUAGE': 'en_US:en', 04:29:38 INFO - 'LOGNAME': 'cltbld', 04:29:38 INFO - 'MAIL': '/var/mail/cltbld', 04:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:38 INFO - 'MOZ_NO_REMOTE': '1', 04:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:38 INFO - 'NO_EM_RESTART': '1', 04:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:38 INFO - 'PWD': '/builds/slave/test', 04:29:38 INFO - 'SHELL': '/bin/bash', 04:29:38 INFO - 'SHLVL': '1', 04:29:38 INFO - 'TERM': 'linux', 04:29:38 INFO - 'TMOUT': '86400', 04:29:38 INFO - 'USER': 'cltbld', 04:29:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:38 INFO - '_': '/tools/buildbot/bin/python'} 04:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:29:38 INFO - Cleaning up... 04:29:38 INFO - Return code: 0 04:29:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:38 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:38 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:29:38 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:29:38 INFO - Using env: {'DISPLAY': ':0', 04:29:38 INFO - 'HOME': '/home/cltbld', 04:29:38 INFO - 'LANG': 'en_US.UTF-8', 04:29:38 INFO - 'LANGUAGE': 'en_US:en', 04:29:38 INFO - 'LOGNAME': 'cltbld', 04:29:38 INFO - 'MAIL': '/var/mail/cltbld', 04:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:38 INFO - 'MOZ_NO_REMOTE': '1', 04:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:38 INFO - 'NO_EM_RESTART': '1', 04:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:38 INFO - 'PWD': '/builds/slave/test', 04:29:38 INFO - 'SHELL': '/bin/bash', 04:29:38 INFO - 'SHLVL': '1', 04:29:38 INFO - 'TERM': 'linux', 04:29:38 INFO - 'TMOUT': '86400', 04:29:38 INFO - 'USER': 'cltbld', 04:29:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:38 INFO - '_': '/tools/buildbot/bin/python'} 04:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29: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:29: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:29: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:29: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:29: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:29: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:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29: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:29: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:29: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:29: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:29: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:29: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:29:41 INFO - Downloading docopt-0.6.1.tar.gz 04:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:41 INFO - Running setup.py install for blobuploader 04:29:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:41 INFO - Running setup.py install for requests 04:29:41 INFO - Running setup.py install for docopt 04:29:41 INFO - Successfully installed blobuploader requests docopt 04:29:41 INFO - Cleaning up... 04:29:41 INFO - Return code: 0 04:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:41 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:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:41 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:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:41 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:41 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:29:41 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:29:41 INFO - Using env: {'DISPLAY': ':0', 04:29:41 INFO - 'HOME': '/home/cltbld', 04:29:41 INFO - 'LANG': 'en_US.UTF-8', 04:29:41 INFO - 'LANGUAGE': 'en_US:en', 04:29:41 INFO - 'LOGNAME': 'cltbld', 04:29:41 INFO - 'MAIL': '/var/mail/cltbld', 04:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:41 INFO - 'MOZ_NO_REMOTE': '1', 04:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:41 INFO - 'NO_EM_RESTART': '1', 04:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:41 INFO - 'PWD': '/builds/slave/test', 04:29:41 INFO - 'SHELL': '/bin/bash', 04:29:41 INFO - 'SHLVL': '1', 04:29:41 INFO - 'TERM': 'linux', 04:29:41 INFO - 'TMOUT': '86400', 04:29:41 INFO - 'USER': 'cltbld', 04:29:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:41 INFO - '_': '/tools/buildbot/bin/python'} 04:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:42 INFO - Running setup.py (path:/tmp/pip-4PdZqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:42 INFO - Running setup.py (path:/tmp/pip-Q9gceR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:42 INFO - Running setup.py (path:/tmp/pip-wKrWCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:42 INFO - Running setup.py (path:/tmp/pip-RuUeOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:42 INFO - Running setup.py (path:/tmp/pip-ZwuGVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:42 INFO - Running setup.py (path:/tmp/pip-Dt33ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:42 INFO - Running setup.py (path:/tmp/pip-XWjSVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:42 INFO - Running setup.py (path:/tmp/pip-s2uTyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:42 INFO - Running setup.py (path:/tmp/pip-CdWYzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:42 INFO - Running setup.py (path:/tmp/pip-9ips6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:42 INFO - Running setup.py (path:/tmp/pip-5Rvh8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:42 INFO - Running setup.py (path:/tmp/pip-Sz_RRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:42 INFO - Running setup.py (path:/tmp/pip-tZlkpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:43 INFO - Running setup.py (path:/tmp/pip-w5ysO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:43 INFO - Running setup.py (path:/tmp/pip-cIDTq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:43 INFO - Running setup.py (path:/tmp/pip-C7iD2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:43 INFO - Running setup.py (path:/tmp/pip-ay1kmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:43 INFO - Running setup.py install for manifestparser 04:29:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:43 INFO - Running setup.py install for mozcrash 04:29:43 INFO - Running setup.py install for mozdebug 04:29:43 INFO - Running setup.py install for mozdevice 04:29:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:43 INFO - Running setup.py install for mozfile 04:29:43 INFO - Running setup.py install for mozhttpd 04:29:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:43 INFO - Running setup.py install for mozinfo 04:29:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozInstall 04:29:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozleak 04:29:44 INFO - Running setup.py install for mozlog 04:29:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for moznetwork 04:29:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozprocess 04:29:44 INFO - Running setup.py install for mozprofile 04:29:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozrunner 04:29:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozscreenshot 04:29:44 INFO - Running setup.py install for moztest 04:29:45 INFO - Running setup.py install for mozversion 04:29:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:45 INFO - Cleaning up... 04:29:45 INFO - Return code: 0 04:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:45 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:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:45 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:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:45 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:45 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:29:45 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:29:45 INFO - Using env: {'DISPLAY': ':0', 04:29:45 INFO - 'HOME': '/home/cltbld', 04:29:45 INFO - 'LANG': 'en_US.UTF-8', 04:29:45 INFO - 'LANGUAGE': 'en_US:en', 04:29:45 INFO - 'LOGNAME': 'cltbld', 04:29:45 INFO - 'MAIL': '/var/mail/cltbld', 04:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:45 INFO - 'MOZ_NO_REMOTE': '1', 04:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:45 INFO - 'NO_EM_RESTART': '1', 04:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:45 INFO - 'PWD': '/builds/slave/test', 04:29:45 INFO - 'SHELL': '/bin/bash', 04:29:45 INFO - 'SHLVL': '1', 04:29:45 INFO - 'TERM': 'linux', 04:29:45 INFO - 'TMOUT': '86400', 04:29:45 INFO - 'USER': 'cltbld', 04:29:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:45 INFO - '_': '/tools/buildbot/bin/python'} 04:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:45 INFO - Running setup.py (path:/tmp/pip-h66gln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:45 INFO - Running setup.py (path:/tmp/pip-NiYX9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:45 INFO - Running setup.py (path:/tmp/pip-3uowK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:45 INFO - Running setup.py (path:/tmp/pip-ThWhr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:45 INFO - Running setup.py (path:/tmp/pip-f1LCEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:45 INFO - Running setup.py (path:/tmp/pip-lM85PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:45 INFO - Running setup.py (path:/tmp/pip-fVKqdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:45 INFO - Running setup.py (path:/tmp/pip-CczVzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:45 INFO - Running setup.py (path:/tmp/pip-lJ0u3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:46 INFO - Running setup.py (path:/tmp/pip-Ko3eJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:46 INFO - Running setup.py (path:/tmp/pip-c0DJnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:46 INFO - Running setup.py (path:/tmp/pip-DPzV7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:46 INFO - Running setup.py (path:/tmp/pip-e7Y3FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:46 INFO - Running setup.py (path:/tmp/pip-_neIIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:46 INFO - Running setup.py (path:/tmp/pip-KKxadH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:46 INFO - Running setup.py (path:/tmp/pip-3VinW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:46 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:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:46 INFO - Running setup.py (path:/tmp/pip-sAaGLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:48 INFO - Downloading blessings-1.6.tar.gz 04:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:48 INFO - Installing collected packages: blessings 04:29:48 INFO - Running setup.py install for blessings 04:29:48 INFO - Successfully installed blessings 04:29:48 INFO - Cleaning up... 04:29:48 INFO - Return code: 0 04:29:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:49 INFO - Reading from file tmpfile_stdout 04:29:49 INFO - Current package versions: 04:29:49 INFO - argparse == 1.2.1 04:29:49 INFO - blessings == 1.6 04:29:49 INFO - blobuploader == 1.2.4 04:29:49 INFO - docopt == 0.6.1 04:29:49 INFO - functools32 == 3.2.3-2 04:29:49 INFO - jsonschema == 2.5.1 04:29:49 INFO - manifestparser == 1.1 04:29:49 INFO - mozInstall == 1.12 04:29:49 INFO - mozcrash == 1.0 04:29:49 INFO - mozdebug == 0.1 04:29:49 INFO - mozdevice == 0.49 04:29:49 INFO - mozfile == 1.2 04:29:49 INFO - mozhttpd == 0.7 04:29:49 INFO - mozinfo == 0.9 04:29:49 INFO - mozleak == 0.1 04:29:49 INFO - mozlog == 3.4 04:29:49 INFO - moznetwork == 0.27 04:29:49 INFO - mozprocess == 0.25 04:29:49 INFO - mozprofile == 0.28 04:29:49 INFO - mozrunner == 6.13 04:29:49 INFO - mozscreenshot == 0.1 04:29:49 INFO - mozsystemmonitor == 0.3 04:29:49 INFO - moztest == 0.8 04:29:49 INFO - mozversion == 1.4 04:29:49 INFO - psutil == 3.1.1 04:29:49 INFO - requests == 1.2.3 04:29:49 INFO - wsgiref == 0.1.2 04:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 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 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:49 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:29:49 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:29:49 INFO - Using env: {'DISPLAY': ':0', 04:29:49 INFO - 'HOME': '/home/cltbld', 04:29:49 INFO - 'LANG': 'en_US.UTF-8', 04:29:49 INFO - 'LANGUAGE': 'en_US:en', 04:29:49 INFO - 'LOGNAME': 'cltbld', 04:29:49 INFO - 'MAIL': '/var/mail/cltbld', 04:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:49 INFO - 'MOZ_NO_REMOTE': '1', 04:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:49 INFO - 'NO_EM_RESTART': '1', 04:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:49 INFO - 'PWD': '/builds/slave/test', 04:29:49 INFO - 'SHELL': '/bin/bash', 04:29:49 INFO - 'SHLVL': '1', 04:29:49 INFO - 'TERM': 'linux', 04:29:49 INFO - 'TMOUT': '86400', 04:29:49 INFO - 'USER': 'cltbld', 04:29:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:49 INFO - '_': '/tools/buildbot/bin/python'} 04:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:49 INFO - Cleaning up... 04:29:49 INFO - Return code: 0 04:29:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, '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': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', '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:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:49 INFO - Using env: {'DISPLAY': ':0', 04:29:49 INFO - 'HOME': '/home/cltbld', 04:29:49 INFO - 'LANG': 'en_US.UTF-8', 04:29:49 INFO - 'LANGUAGE': 'en_US:en', 04:29:49 INFO - 'LOGNAME': 'cltbld', 04:29:49 INFO - 'MAIL': '/var/mail/cltbld', 04:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:49 INFO - 'MOZ_NO_REMOTE': '1', 04:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:49 INFO - 'NO_EM_RESTART': '1', 04:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:49 INFO - 'PWD': '/builds/slave/test', 04:29:49 INFO - 'SHELL': '/bin/bash', 04:29:49 INFO - 'SHLVL': '1', 04:29:49 INFO - 'TERM': 'linux', 04:29:49 INFO - 'TMOUT': '86400', 04:29:49 INFO - 'USER': 'cltbld', 04:29:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:49 INFO - '_': '/tools/buildbot/bin/python'} 04:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:29:49 INFO - Cleaning up... 04:29:49 INFO - Return code: 0 04:29:49 INFO - Running post-action listener: _resource_record_post_action 04:29:49 INFO - Running post-action listener: _start_resource_monitoring 04:29:49 INFO - Starting resource monitoring. 04:29:49 INFO - [mozharness: 2017-03-31 11:29:49.604252Z] Finished create-virtualenv step (success) 04:29:49 INFO - [mozharness: 2017-03-31 11:29:49.604727Z] Running install step. 04:29:49 INFO - Running pre-action listener: _resource_record_pre_action 04:29:49 INFO - Running main action method: install 04:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:49 INFO - Reading from file tmpfile_stdout 04:29:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:49 INFO - Reading from file tmpfile_stdout 04:29:49 INFO - Output received: 04:29:49 INFO - Usage: mozinstall [options] installer 04:29:49 INFO - Options: 04:29:49 INFO - -h, --help show this help message and exit 04:29:49 INFO - -d DEST, --destination=DEST 04:29:49 INFO - Directory to install application into. [default: 04:29:49 INFO - "/builds/slave/test"] 04:29:49 INFO - --app=APP Application being installed. [default: firefox] 04:29:49 INFO - mkdir: /builds/slave/test/build/application 04:29:49 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:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:30:05 INFO - Reading from file tmpfile_stdout 04:30:05 INFO - Output received: 04:30:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:05 INFO - Running post-action listener: _resource_record_post_action 04:30:05 INFO - [mozharness: 2017-03-31 11:30:05.571107Z] Finished install step (success) 04:30:05 INFO - [mozharness: 2017-03-31 11:30:05.571382Z] Running run-tests step. 04:30:05 INFO - Running pre-action listener: _resource_record_pre_action 04:30:05 INFO - Running main action method: run_tests 04:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:05 INFO - Python 2.7.3 04:30:05 INFO - Return code: 0 04:30:05 INFO - grabbing minidump binary from tooltool 04:30:05 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:30:05 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 0x2723290>, '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 0x2723b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:05 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:30:05 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:30:05 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:30:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:05 INFO - Return code: 0 04:30:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:05 INFO - ENV: RUST_BACKTRACE is now 1 04:30:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:05 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:30:05 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:30:05 INFO - Using env: {'DISPLAY': ':0', 04:30:05 INFO - 'HOME': '/home/cltbld', 04:30:05 INFO - 'LANG': 'en_US.UTF-8', 04:30:05 INFO - 'LANGUAGE': 'en_US:en', 04:30:05 INFO - 'LOGNAME': 'cltbld', 04:30:05 INFO - 'MAIL': '/var/mail/cltbld', 04:30:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:05 INFO - 'MOZ_NO_REMOTE': '1', 04:30:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:05 INFO - 'NO_EM_RESTART': '1', 04:30:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:05 INFO - 'PWD': '/builds/slave/test', 04:30:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:05 INFO - 'RUST_BACKTRACE': '1', 04:30:05 INFO - 'SHELL': '/bin/bash', 04:30:05 INFO - 'SHLVL': '1', 04:30:05 INFO - 'TERM': 'linux', 04:30:05 INFO - 'TMOUT': '86400', 04:30:05 INFO - 'USER': 'cltbld', 04:30:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726', 04:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:05 INFO - '_': '/tools/buildbot/bin/python'} 04:30:05 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/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:30:05 INFO - mozversion application_buildid: 20170330114804 04:30:05 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:05 INFO - mozversion application_display_name: Nightly 04:30:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:05 INFO - mozversion application_name: Firefox 04:30:05 INFO - mozversion application_remotingname: firefox 04:30:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:05 INFO - mozversion application_vendor: Mozilla 04:30:05 INFO - mozversion application_version: 55.0a1 04:30:05 INFO - mozversion platform_buildid: 20170330114804 04:30:05 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:05 INFO - mozversion platform_version: 55.0a1 04:30:05 INFO - using testdate: 1490959805 04:30:05 INFO - actual date: 1490959805 04:30:05 INFO - starting webserver on 'localhost:48868' 04:30:05 INFO - SUITE-START | Running 2 tests 04:30:05 INFO - TEST-START | dromaeo_css 04:30:05 INFO - operating with platform_type : linux_ 04:30:05 INFO - Initialising browser for dromaeo_css test... 04:30:05 INFO - TEST-INFO | started process 4944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX2ev8i/profile http://localhost:48868/getInfo.html) 04:30:10 INFO - PID 4944 | __metrics Screen width/height:1600/1200 04:30:10 INFO - PID 4944 | colorDepth:24 04:30:10 INFO - PID 4944 | Browser inner width/height: 1024/697 04:30:10 INFO - PID 4944 | __metrics 04:30:11 ERROR - PID 4944 | 1490959811684 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:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpX2ev8i/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpX2ev8i/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpX2ev8i/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpX2ev8i/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:30:11 ERROR - PID 4944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:30:12 INFO - TEST-INFO | 4944: exit 0 04:30:12 INFO - Browser initialized. 04:30:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:12 INFO - TEST-INFO | started process 5075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX2ev8i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:24 INFO - PID 5075 | RSS: Main: 155779072 04:30:24 INFO - PID 5075 | 04:33:29 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48868/tests/dromaeo/cssquery-ext.html) 04:33:32 INFO - PID 5075 | RSS: Main: 164884480 04:33:32 INFO - PID 5075 | 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 5075 | 04:35:13 ERROR - PID 5075 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 5075 | Full stack: 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 5075 | 04:35:13 ERROR - PID 5075 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 5075 | Full stack: 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 5075 | 04:35:13 ERROR - PID 5075 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 5075 | Full stack: 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | ************************* 04:35:13 INFO - PID 5075 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 5075 | 04:35:13 ERROR - PID 5075 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 5075 | Full stack: 04:35:13 INFO - PID 5075 | ************************* 04:36:34 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-ext.html (next: http://localhost:48868/tests/dromaeo/cssquery-jquery.html) 04:36:35 INFO - PID 5075 | RSS: Main: 161890304 04:36:35 INFO - PID 5075 | 04:39:37 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48868/tests/dromaeo/cssquery-mootools.html) 04:39:38 INFO - PID 5075 | RSS: Main: 169705472 04:39:38 INFO - PID 5075 | 04:42:40 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48868/tests/dromaeo/cssquery-prototype.html) 04:42:40 INFO - PID 5075 | RSS: Main: 162131968 04:42:40 INFO - PID 5075 | 04:45:43 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48868/tests/dromaeo/cssquery-yui.html) 04:45:44 INFO - PID 5075 | RSS: Main: 169267200 04:45:44 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | Cycle 1(1): loaded http://localhost:48868/tests/dromaeo/cssquery-yui.html (next: http://localhost:48868/tests/dromaeo/cssquery-dojo.html) 04:48:47 INFO - PID 5075 | RSS: Main: 162086912 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | __start_tp_report 04:48:47 INFO - PID 5075 | _x_x_mozilla_page_load 04:48:47 INFO - PID 5075 | _x_x_mozilla_page_load_details 04:48:47 INFO - PID 5075 | |i|pagename|runs| 04:48:47 INFO - PID 5075 | |0;dojo.html;2697.757201851833;2729.5359788835895;2733.2346942856007;2760.3375189954418;2762.654668166479;5191.662541934772;5257.447967963361;5274.498922602352;5313.78744850206;5348.839534813962;5148.948510514893;5247.396549396811;5247.527722504974;5358.437364076774;5361.222622719703;4777.402824646928;4821.493743156971;4842.564169224769;4850.296706977486;4871.318015477836;4829.082474329866;4840.00779840132;4889.095517329305;4893.902121957559;4950.405951285833;4727.598154156901;4758.714477131383;4782.665213435061;4806.831760888387;4814.903701925977;4819.397575303087;4833.854984350475;4840.934994301283;4868.732219727914;4878.707277563358;4708.882277943045;4789.976050119762;4796.52034796521;4811.855644330676;4834.299026641117;5086.41506226785;5177.559907407875;5250.238715386286;5270.8155214567305;5330.093884039723;5560.638558493725;5577.274954255961;5625.071863142576;5625.915611265835;5629.662220266797;5693.202951586781;5695.629784064023;5704.030314846486;5712.057510510761;5714.7428365723645;5107.208382700687;5273.340832395912;5287.7884884604955;5297.443768404339;5347.117725575315;5769.1923130761725;5813.651180929073;5859.326177489644;5864.47219750216;5904.911426328608;5437.782488700408;5533.501984821305;5534.944650553443;5600.383957764642;5607.915881261784;5664.291963504562;5690.118031705009;5698.715064246771;5705.115707065412;5710.942890571041;5653.321601407857;5665.971670141623;5666.093425051972;5677.148427735872;5679.630823996509;5455.263539422127;5526.949879522877;5535.944640553624;5538.501534861801;5539.972300138474;4761.262004389325;4774.427068751703;4774.928376074362;4779.115863565252;4793.23308270682;4125.752454852658;4140.772257525805;4141.192467468814;4144.5233798113;4151.91696166075;4823.927641085386;4837.56461918422;4838.250071238964;4841.878953026132;4845;5642;5659.6699775552715;5666.320041595035;5675;5695.544356451557;4849.199882019498;4853.247746599282;4857.587105096036;4860.125177468019;4862.246351815475;5031.52200540948;5034.89930201394;5038.571721403649;5039.571636410873;5046.091703493333;5312.574994000471;5342.973285133549;5351.411344752152;5351.598630102758;5399.676019438768;5579.330480342385;5673.687947162945;5683.005474041944;5722.542196624343;5738.282714660668;5222.582193424593;5227.111391063604;5232.319798426181;5233.555147812326;5235.633505654568;5379.273798037371;5484.698341591251;5500.1749737539685;5500.724963751876;5533.667979921218;5547.7780888764;5579.776808927598;5580.693061881636;5582.8325150245555;5583.441655834384;5494.313210848644;5501.449855014466;5509.146082357241;5545.72271386421;5590.664560126405;5468.972655136698;5501.889962200654;5511.255980442589;5558.777648893999;5569.10894256917;5454;5471.9179212311055;5481.917771233514;5485.040117979417;5500.697461639648;5397.892042159214;5439.374471935778;5568.610197286313;5590.273264475592;5637.408072152365;5410.161424979135;5435.211894275229;5438.700871452108;5448;5448.427915068861 04:48:47 INFO - PID 5075 | |1;ext.html;631.1164369882165;644.3846126948764;1064.7072055184824;1073.8067147913378;1188.3820413385045;33906.15234619136;35105.82447087764;35109.297814043704;35317.64682353172;35432.82283588578;32169;32645.51031734526;32659.67340326602;32757.344853102924;32763.344733105325;6948.409385202264;7082.610456424894;7337.926620733804;7352.264773522658;7415.703371865119;7492.325690687837;7550.924490755105;7567.091948966105;7576.734814281501;7590.7722768317035;7511.436642251826;7597.886031709529;7616.657250423744;7619.238076192391;7636.083669959613;7564.092308922965;7579;7592.164861865191;7603.733869314603;7629.427792915526;7467.626618669099;7470.887936680954;7476.214997425246;7498.775036748906;7500.474966752329;34428.827855860814;34445;34454.138646533786;34574.82712586446;34616.30767384663;2582.57387531059;2637.6175454559175;2638.28766233116;2668.4796464689393;2674.2645772412548;23070.7692923072;23266.185683501164;24057.51884962291;24233.878830605736;24682.50634987308;2474.2453551666736;2516.5218608464515;2523.1421316752394;2565.2560757380525;2648.311439025848;150501;151275.24362378227;152391;152471;152477.23761381232;41125;41166.79416602898;41250.58749412528;41360;41952.370714439305;45030.32454513185;45297.547024529995;45418;45429;45432.772836135606;12710.42803073864;12875.163114397534;12898.67753306175;12917.160384574972;12919.483220671067;10135.391876487287;10142.391456512632;10182.18542516597;10184.898151018395;10191.898081019242;12904.870951290366;12980.935095324463;12986.155899866479;13105.082644214814;13180.143290686075;5372.946270537244;5411.594130440233;5489.64317319373;5515.365732940683;5603.691796951207;833.7457075591882;844.4004756622744;871.5685735560811;891.7057371067532;904.7918978634951;18418.057191711145;18846.905765471085;19361.51596210106;19910.203591856454;20155.294564690164;954.3224310739314;956.1585804492141;957.8850537935492;969.2633598465217;973.1387721866199;9693.515324233902;9945.403275803475;10400;10422.166226701846;10532.15742740579;253946;257594;257809;258047;258688;43823.12353752907;44108.3383749244;44338.33492497615;44526.55473445289;44579.33131003038;1184.8518935133109;1232.4084439469104;1232.9876701232872;1244.104244943639;1257.2330878164312;18221.362252321105;18292.908535457238;18748.531286717942;19054.333098341493;19404.514887127934;30383.696163038087;30572.694273056986;30655.386892262475;30689.232769180948;30697.386052279275;228710;229244;229590;229634;230042;29502.704972949996;30221.244468888453;30404.69595304107;30517;30780.692193078678;35325.470117947734;35427.645723543465;35610.82194589114;36347;36620.45069323909;26487.735122648526;26585.33536661599;27065.59401609017;27282.454350912474;27784.722152778213;27040.594391083756;27339.453210936066;27606.585901211096;28250.2937426566;28254;29679;30003.84998075083;30249;30491.2377190572;30647.62085706104;26904.596431053942;27022.864885675444;27035.1889443317;27112.593311099954;27822.165335039983;20621.484462888548;21858.781412185675;21920.23279185221;22072.117115315206;22173.33479995603 04:48:47 INFO - PID 5075 | |2;jquery.html;408.50978825409516;414.42601996235203;421.7406295128495;429.07320188393055;436.3215200363435;16152.353905843753;17700.64598708025;18156.81843181568;18401.99999999998;18437.078146092692;16160.676786464264;16532.09073500957;16645.33418663252;16731.83268167318;16777.580560485992;5662.235598194253;5921.585489015771;5925.88148237035;6240.968795156041;6498.967505162467;6482.93517064828;6521.054447105167;6521.413072823445;6524.804255872332;6528.41244288014;6160.260768707739;6426.421622054014;6444.162258906335;6464.547481676284;6467.029945508164;6200.565960382775;6368.872622547523;6423.421892029716;6440.291567927524;6476.158099447089;6245.281792593864;6259;6262.436380725711;6271.843203919893;6295.150154729099;23129;23371.182008629785;23826.880865595733;23949.521009579712;24303.270901872973;1563.7888885000493;1606.3574570171909;1618.304129224433;1627.4222650958857;1668.5661727950699;15096.320665570076;15250.923745381313;15554.688906221812;15850.048997060214;15890.126043067627;1730.723084306505;1788.856891448681;1799.7480352750626;1814.5735752098246;1834.7981722010568;88978.5551072247;94711;94998.05001949961;95382;96076;17550;17637;17681.557961051076;18449.631007380045;18560.164792584364;32349.191270218435;32425.351492970007;32625.14871876885;32705.50941735876;32780.67219327824;8670.566471676391;8817.16236957488;8896;9022.819543609092;9125.498097604695;6975.581465112109;7045.929540704527;7131.786046418616;7209.89185162223;7218.169910460259;9259.768505787275;9349.672761453452;9451.251518469106;9558.665446709332;9609.519524023772;3835.9232815343535;3963.3460479020637;3965.8413663453716;4060.7766572838186;4065.3495440729935;836.9665213391396;849.180540778152;861.4357595774777;865.2472349056361;877.5910126702244;15736.68526629461;16738.4141555045;16790.58023549421;16963.40628078036;16977.830221697626;866.4324867211986;866.5147517390282;873.4235404632911;894.5303715549388;903.2322525852973;8752.69365572202;9133.90866091344;9220.492872892055;9247.665349235795;9298.814023719488;414822;415752;474987;479918;483863;91812.54093729489;96976.51511742396;97209;98529.5073524642;98928;1046.7121541576128;1079.9190060745475;1102.2284400919548;1108.141190577309;1117.7596816684452;17593.296268149643;17739.911300443415;18022.639547209244;18366.173522191268;18733.437996860117;42772.572274276856;42837.785811070746;42845;43389.783051085804;43866.780666097744;55150.17274740802;55555.16667249914;56003.71998139983;56193;56478.71760641171;8074.111847696631;8121.309688676529;8154.714584989497;8330.458520196411;8431.578421079044;12949.805752913526;13030.54393096275;13064.648363294698;13160.276184809927;13350;10550.208734344802;10920.726981825517;11303.71740706456;11448.885511144781;11921.165518413627;10203.28576999603;10385.22110841705;10498.107660848913;10569.788604227719;10593.788124237626;10641.680749577525;10900.291481053706;10915.235933484897;10967.945160274467;12166.330851803235;8209.753707388787;8231.46495477792;8437.029741579798;8473.110323416198;8666.003409607976;10369.74075648115;10969.341839489656;10996.725081872697;11242.145046067308;11256.606018789304 04:48:47 INFO - PID 5075 | |3;mootools.html;1267.3789842976942;1328.4752522753513;1336.1181620130722;1336.2984433172583;1338.0967846703472;9453.101955314243;9828.803423931517;9845.7538561536;9930.106290433878;10260.743481412968;9870.950645246763;10022.699319020441;10085.142762865165;10104.242181836373;10113.292069555135;2141.4004078857906;2163.3834357208198;2163.394249610104;2176.4450065233345;2178.880161591112;2115.3019503563864;2120.6818977153475;2125.2880285104507;2164.2641501889357;2225.543763528473;1984.6030793841217;2041.9183232670675;2054.465838881894;2054.5479994401285;2124.479502521884;2142.967855482169;2148.1622167354744;2153.106460818766;2159.6436587962967;2166.068590506082;1817.7455156278131;1880.69908814589;2073.906674199665;2082.2607974169105;2129.2441183379833;9703.51482425883;9803.068708472683;9810.656627018092;9821.165200957856;9829.361091529028;5346.625736198468;5546.195801608744;5554.611177217596;5557.138643510262;5558.360788509332;3276.311974485361;3317.7345812334956;3414.197663549064;3431.673990970854;3466.739994500397;1030.5362586835954;1036.9792604147951;1038.2317085356858;1049.5486940615533;1099.3239157917824;14029.158250504901;14040.438382464688;14080.92959535206;14095.2952352383;14170.71658566823;4675.434126455244;4759.595434388047;4805.13507568641;4878.195097808822;4905.288733133676;10515.369077855354;10525.9473702631;10531.57873685044;10543;10558.947205263925;5432.972835135799;5433.049216387117;5439.041944899833;5456.208849716769;5463.7814487420055;4721.976390118028;4797.520247975244;4970.304157417964;4992.600591952635;5042.344495215599;3680.9447858282147;3702.740808143458;3733.3093377724663;3802.296575133609;3838.980805095957;1120.7422292872684;1139.7606502634374;1142.7485953090306;1149.7930372532858;1158.0503986730969;647.5693663713578;672.4015626092781;676.2426082787211;677.8712044711489;682.7644462660375;5006.6245031622775;5048.116579598555;5103.821366252238;5107.412647545506;5168.61235407346;527.9630425870229;537.9973100134553;541.9891602167935;543.5923057706719;546.6528754241085;3069.938601227963;3105.891293804706;3110.28463453407;3150.054983504985;3223.4520131577688;11827.940860295816;12386.876131238752;12749.745005100032;12788.744225115632;12812.871871281355;12584.937075314565;12601.243925364324;12615.810762838564;12616.116871818884;12648.494060237488;8800.779980500538;8935;8986.86519702205;8991.955040224757;9007.729768106967;5373.247745315581;5432.212329212163;5436.130219164915;5456.236126942311;5652.660840349592;11162.776744465227;11170.664880053611;11194.496247668712;11328.546858125912;11629.185956983269;11459.541618335174;11504.769904602028;11566.94216528912;11596.710082248012;11839.112066595211;7372.668229929774;7451.478396512192;7458.142313634002;7473.962630186814;7549.282818132268;8949.284057275272;9049.457032578066;9122.498262595622;9144.3598948073;9160.358774885693;7293.854122917406;7384.187739348775;7430.517016394133;7432.996545466292;7454.776356709307;6898.586084834926;6968.128983877015;6986.336298051677;6989.126359205099;6996.685149168198;6198.597091189058;6316.905246421215;6325.683715814283;6328.6202827830475;6329.683515824282;4658.906821863611;4754.144254034307;4779.187538118597;4881.755912204447;4973.950260497349;4714.764261786965;4807.158747219153;4853.975730121327;4937.259411088366;4949.059678661043 04:48:47 INFO - PID 5075 | |4;prototype.html;369.18226129123985;391.3327776141678;391.47737770076947;393.527766679984;398.93218152914;5464.398916119224;5553.694546799924;5585.134304182848;5654.293213348326;5661.575381846357;5375.3280839895015;5471.534919531835;5472.91790623141;5482.095454250044;5483.656504156477;4251.3622956556455;4255.616994470497;4260.595243451882;4275.572442755715;4285.421468101813;4033.6773058155277;4230.17511585241;4280.850170244042;4283.079137985333;4283.850065247717;4188.183304255671;4201.886500077482;4212.705110642256;4214.072903961123;4214.789260536976;4203.831846726127;4213.157368526292;4215.978920105411;4219.198352313051;4225.598568136023;3669.9082522936874;3670;3676.246369494247;3696.2977034363385;3716.2939041582013;5142.61430392722;5297.841064768063;5325.866853328659;5331.520163185293;5333.439988801198;4801.15979703554;4806.351142595775;4849.951500484985;4850.957044235506;4853.757312134415;5535.612507124503;5679.176519404705;5710.428957104298;5722.771089156428;5733.713314334266;4028.133951200506;4034.5561988181275;4034.628226403037;4043.65628921542;4046.7976601170117;5928.7628494860155;6050.515958723292;6081.1790408294755;6099.090232362946;6129.1419201311855;4067.1255680028344;4075;4077.429159917614;4086.1623367210245;4112.814923328458;4139.710220284612;4144.91710165795;4147.564505726916;4149.813258403379;4153.626173644326;4645.39609850724;4777.713337199779;4813.9037219255415;4823.204171311694;4826.155422800995;5770.538356931435;5770.6249093808765;5781.161731548902;5783;5785.942140578624;1438.2305466575333;1459.8540145985316;1460.8685218330402;1461.7515022445998;1465.1428914085166;934.7823941090024;970.7961328121173;975.7511834482303;988.2538683294067;1000.8740167311774;5045.167547354646;5064.772085256172;5070.7464626768515;5093.18509038552;5095.414027386898;6013.1581578579035;6043.48630366415;6049.516038716892;6053.545984051126;6062.242219722535;4861.732604706775;5014.84955451337;5041.873953151201;5052.9242061369105;5089.949100508948;3164.398764234788;3190.3300306935803;3196;3219.2917558137174;3222.758293128025;5564.499195072382;5578.609497335228;5583.35791383996;5590.273264475592;5605.915911261334;5879.2944846618675;6133.76117717039;6137.7851775187655;6170.59346854727;6174.919389106888;5567.248421463131;5574.386817450078;5603.3836278009385;5607.299087614048;5629.352624448159;5806.303243610793;5937.2578427696535;5986.132010858314;6009.699515024318;6014.939850601613;5876.3536011037895;5900.586958912835;5919.052951527735;5944.8811023780145;5948.078047902582;5385.515303622693;5564.10974244119;5564.221009058654;5592.496675299242;5608.495235428668;4115.382692596135;4146.688998325078;4149;4155.148194620156;4174.937375939424;5900.355978491531;5921.407859214044;5992.490638295793;6024.156618073385;6032.788852390146;5768.807853015827;5789.421057894346;5794.275715535558;5794.420557944172;5818.4763371296785;5803.564732645153;5820.76716931335;5822.82531524055;5827.825165245049;5838.649681019152;5593.161025846156;5688.232088668143;5724.227229323988;5763.452472015152;5769.971150144391;5866.208061911588;5868.882622347614;5875.676837773964;5892.410758924073;5900.763969441346;5493.258410114583;5720.942790572208;5732.627379220337;5734.397888221677;5740.827775166752 04:48:47 INFO - PID 5075 | |5;yui.html;586.3579380578268;608.8203979825951;616.7717944360586;619.5136817598186;634.2642534659796;13326;13462.59612211634;13784.448622055119;13784.448622055119;14165.220912849789;12723.491060357575;12783.233006019645;12796.168249063805;12801.807972880391;12814.03894707896;889.5952341684518;895.9686410975618;922.4787994782927;922.8754118194058;926.2404828041009;898.6001229452896;905.0180554098811;905.1853332001218;908.2280061947325;953.4994128082777;926.7590426489128;938.4134915677702;939.3847030195199;941.0777438110656;992.6724181020282;912.7124955639019;923.2475532441039;927.5130556457846;929.330881765128;979.1187930862245;680.7379159023811;682.9282925292822;683.8119517132778;702.4801646781345;729.0740759235794;13594.38825252866;13615.59153225395;13635.386407611582;13639.454421823115;13897.235652039133;12781.680457988532;13199;13479.932600337033;13652.726945461134;13723.118145189523;8601.913980860236;8811.691590794355;8857.689980850704;9059.547022648907;9166.266698664158;2254.425121593983;2257.6500642400456;2268.8184945204343;2343.5078633486987;2366.8816559171973;63742.68128659373;63850.68074659644;64135.358646413406;65328.3467165327;66491.335086649;10049.949750251202;10231.795364092824;10235.029552826963;10456.111230545488;10618.681439556825;19719.112639931238;21472.355829325144;21757.782422175893;22043.228487002878;22075.227367042397;6025;6082.300535438393;6187.876242475125;6224.502039836802;6365.61806291624;2818.365867679756;2892.132360291946;2922.7369536741794;2959.689232630543;2984.4031193761334;3433.828308584561;3461.480777883338;3488.127968007998;3492.4935884296633;3527.294541091792;643.9356064393617;645.4255712415953;654.1300070905684;663.1081195791653;667.1293961380445;455.67191622032084;470.1631096647972;475.4840997517732;484.41627838454576;487.23747335419955;7277.345038946521;7443.292887175709;7685.538867667958;7719.65261563231;7737.419693523008;451.85766483557575;458.35679090460405;475.79540797456735;477.0816178855689;482.8816939849759;3447.172678557178;3448.1207292140843;3460.2733425980323;3486.111041684405;3549.9290014200087;57172;58600;59595.70202148962;63101.36898631047;63192.68403657952;49559.504404955485;50708;50836.49163508391;50994;52533.474665252856;43577.56422435862;46420.30369544459;48089.5191048092;48468.75765621149;48514.75742621264;8094.910660009757;8254.253804062808;8526.488410695378;8543;8559;23702.762972370056;24336;24409.26772196837;25009.874555645405;25391.238262852145;29814.70185298206;29933.850330748206;29988.550171747003;30101.548476772427;30748.385032299677;10541.156707463231;10576.629817956335;10580.001784315778;10747.731306717395;11447.713807154887;10621.681349559525;10624.787504249716;10657.360558366523;10757.731056723644;10827.621033263798;10315.742106447398;10385.896141038493;10666.200034997251;11040.337579744919;11045.171612128961;10582.788344232918;10591.788164236517;10791.730206744895;10840.67477975662;10863.565457381615;9609.423434593948;9746.415215087118;9855.45794981283;10117.29178957466;10168.440735759605;8098.3521318293215;8102.31130353903;8278.793030174053;8326.375521836007;8336.374771892253;8908.153725396078;9167.358284919992;9174.449533028039;9197.494137822485;9222.44665320083 04:48:47 INFO - PID 5075 | __end_tp_report 04:48:47 INFO - PID 5075 | __start_cc_report 04:48:47 INFO - PID 5075 | _x_x_mozilla_cycle_collect,394 04:48:47 INFO - PID 5075 | __end_cc_report 04:48:47 INFO - PID 5075 | __startTimestamp1490960927575__endTimestamp 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | ------- Summary: start ------- 04:48:47 INFO - PID 5075 | Number of tests: 6 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#0] dojo.html Cycles:165 Average:5199.98 Median:5358.44 stddev:581.23 (10.8%) stddev-sans-first:548.86 04:48:47 INFO - PID 5075 | Values: 2697.8 2729.5 2733.2 2760.3 2762.7 5191.7 5257.4 5274.5 5313.8 5348.8 5148.9 5247.4 5247.5 5358.4 5361.2 4777.4 4821.5 4842.6 4850.3 4871.3 4829.1 4840.0 4889.1 4893.9 4950.4 4727.6 4758.7 4782.7 4806.8 4814.9 4819.4 4833.9 4840.9 4868.7 4878.7 4708.9 4790.0 4796.5 4811.9 4834.3 5086.4 5177.6 5250.2 5270.8 5330.1 5560.6 5577.3 5625.1 5625.9 5629.7 5693.2 5695.6 5704.0 5712.1 5714.7 5107.2 5273.3 5287.8 5297.4 5347.1 5769.2 5813.7 5859.3 5864.5 5904.9 5437.8 5533.5 5534.9 5600.4 5607.9 5664.3 5690.1 5698.7 5705.1 5710.9 5653.3 5666.0 5666.1 5677.1 5679.6 5455.3 5526.9 5535.9 5538.5 5540.0 4761.3 4774.4 4774.9 4779.1 4793.2 4125.8 4140.8 4141.2 4144.5 4151.9 4823.9 4837.6 4838.3 4841.9 4845.0 5642.0 5659.7 5666.3 5675.0 5695.5 4849.2 4853.2 4857.6 4860.1 4862.2 5031.5 5034.9 5038.6 5039.6 5046.1 5312.6 5343.0 5351.4 5351.6 5399.7 5579.3 5673.7 5683.0 5722.5 5738.3 5222.6 5227.1 5232.3 5233.6 5235.6 5379.3 5484.7 5500.2 5500.7 5533.7 5547.8 5579.8 5580.7 5582.8 5583.4 5494.3 5501.4 5509.1 5545.7 5590.7 5469.0 5501.9 5511.3 5558.8 5569.1 5454.0 5471.9 5481.9 5485.0 5500.7 5397.9 5439.4 5568.6 5590.3 5637.4 5410.2 5435.2 5438.7 5448.0 5448.4 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#1] ext.html Cycles:180 Average:35068.08 Median:30316.35 stddev:56854.33 (187.5%) stddev-sans-first:56955.03 04:48:47 INFO - PID 5075 | Values: 631.1 644.4 1064.7 1073.8 1188.4 33906.2 35105.8 35109.3 35317.6 35432.8 32169.0 32645.5 32659.7 32757.3 32763.3 6948.4 7082.6 7337.9 7352.3 7415.7 7492.3 7550.9 7567.1 7576.7 7590.8 7511.4 7597.9 7616.7 7619.2 7636.1 7564.1 7579.0 7592.2 7603.7 7629.4 7467.6 7470.9 7476.2 7498.8 7500.5 34428.8 34445.0 34454.1 34574.8 34616.3 2582.6 2637.6 2638.3 2668.5 2674.3 23070.8 23266.2 24057.5 24233.9 24682.5 2474.2 2516.5 2523.1 2565.3 2648.3 150501.0 151275.2 152391.0 152471.0 152477.2 41125.0 41166.8 41250.6 41360.0 41952.4 45030.3 45297.5 45418.0 45429.0 45432.8 12710.4 12875.2 12898.7 12917.2 12919.5 10135.4 10142.4 10182.2 10184.9 10191.9 12904.9 12980.9 12986.2 13105.1 13180.1 5372.9 5411.6 5489.6 5515.4 5603.7 833.7 844.4 871.6 891.7 904.8 18418.1 18846.9 19361.5 19910.2 20155.3 954.3 956.2 957.9 969.3 973.1 9693.5 9945.4 10400.0 10422.2 10532.2 253946.0 257594.0 257809.0 258047.0 258688.0 43823.1 44108.3 44338.3 44526.6 44579.3 1184.9 1232.4 1233.0 1244.1 1257.2 18221.4 18292.9 18748.5 19054.3 19404.5 30383.7 30572.7 30655.4 30689.2 30697.4 228710.0 229244.0 229590.0 229634.0 230042.0 29502.7 30221.2 30404.7 30517.0 30780.7 35325.5 35427.6 35610.8 36347.0 36620.5 26487.7 26585.3 27065.6 27282.5 27784.7 27040.6 27339.5 27606.6 28250.3 28254.0 29679.0 30003.8 30249.0 30491.2 30647.6 26904.6 27022.9 27035.2 27112.6 27822.2 20621.5 21858.8 21920.2 22072.1 22173.3 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#2] jquery.html Cycles:180 Average:29245.11 Median:42805.18 stddev:75504.98 (176.4%) stddev-sans-first:75685.75 04:48:47 INFO - PID 5075 | Values: 408.5 414.4 421.7 429.1 436.3 16152.4 17700.6 18156.8 18402.0 18437.1 16160.7 16532.1 16645.3 16731.8 16777.6 5662.2 5921.6 5925.9 6241.0 6499.0 6482.9 6521.1 6521.4 6524.8 6528.4 6160.3 6426.4 6444.2 6464.5 6467.0 6200.6 6368.9 6423.4 6440.3 6476.2 6245.3 6259.0 6262.4 6271.8 6295.2 23129.0 23371.2 23826.9 23949.5 24303.3 1563.8 1606.4 1618.3 1627.4 1668.6 15096.3 15250.9 15554.7 15850.0 15890.1 1730.7 1788.9 1799.7 1814.6 1834.8 88978.6 94711.0 94998.1 95382.0 96076.0 17550.0 17637.0 17681.6 18449.6 18560.2 32349.2 32425.4 32625.1 32705.5 32780.7 8670.6 8817.2 8896.0 9022.8 9125.5 6975.6 7045.9 7131.8 7209.9 7218.2 9259.8 9349.7 9451.3 9558.7 9609.5 3835.9 3963.3 3965.8 4060.8 4065.3 837.0 849.2 861.4 865.2 877.6 15736.7 16738.4 16790.6 16963.4 16977.8 866.4 866.5 873.4 894.5 903.2 8752.7 9133.9 9220.5 9247.7 9298.8 414822.0 415752.0 474987.0 479918.0 483863.0 91812.5 96976.5 97209.0 98529.5 98928.0 1046.7 1079.9 1102.2 1108.1 1117.8 17593.3 17739.9 18022.6 18366.2 18733.4 42772.6 42837.8 42845.0 43389.8 43866.8 55150.2 55555.2 56003.7 56193.0 56478.7 8074.1 8121.3 8154.7 8330.5 8431.6 12949.8 13030.5 13064.6 13160.3 13350.0 10550.2 10920.7 11303.7 11448.9 11921.2 10203.3 10385.2 10498.1 10569.8 10593.8 10641.7 10900.3 10915.2 10967.9 12166.3 8209.8 8231.5 8437.0 8473.1 8666.0 10369.7 10969.3 10996.7 11242.1 11256.6 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#3] mootools.html Cycles:180 Average:5969.00 Median:4667.17 stddev:3854.87 (82.6%) stddev-sans-first:3849.50 04:48:47 INFO - PID 5075 | Values: 1267.4 1328.5 1336.1 1336.3 1338.1 9453.1 9828.8 9845.8 9930.1 10260.7 9871.0 10022.7 10085.1 10104.2 10113.3 2141.4 2163.4 2163.4 2176.4 2178.9 2115.3 2120.7 2125.3 2164.3 2225.5 1984.6 2041.9 2054.5 2054.5 2124.5 2143.0 2148.2 2153.1 2159.6 2166.1 1817.7 1880.7 2073.9 2082.3 2129.2 9703.5 9803.1 9810.7 9821.2 9829.4 5346.6 5546.2 5554.6 5557.1 5558.4 3276.3 3317.7 3414.2 3431.7 3466.7 1030.5 1037.0 1038.2 1049.5 1099.3 14029.2 14040.4 14080.9 14095.3 14170.7 4675.4 4759.6 4805.1 4878.2 4905.3 10515.4 10525.9 10531.6 10543.0 10558.9 5433.0 5433.0 5439.0 5456.2 5463.8 4722.0 4797.5 4970.3 4992.6 5042.3 3680.9 3702.7 3733.3 3802.3 3839.0 1120.7 1139.8 1142.7 1149.8 1158.1 647.6 672.4 676.2 677.9 682.8 5006.6 5048.1 5103.8 5107.4 5168.6 528.0 538.0 542.0 543.6 546.7 3069.9 3105.9 3110.3 3150.1 3223.5 11827.9 12386.9 12749.7 12788.7 12812.9 12584.9 12601.2 12615.8 12616.1 12648.5 8800.8 8935.0 8986.9 8992.0 9007.7 5373.2 5432.2 5436.1 5456.2 5652.7 11162.8 11170.7 11194.5 11328.5 11629.2 11459.5 11504.8 11566.9 11596.7 11839.1 7372.7 7451.5 7458.1 7474.0 7549.3 8949.3 9049.5 9122.5 9144.4 9160.4 7293.9 7384.2 7430.5 7433.0 7454.8 6898.6 6968.1 6986.3 6989.1 6996.7 6198.6 6316.9 6325.7 6328.6 6329.7 4658.9 4754.1 4779.2 4881.8 4974.0 4714.8 4807.2 4854.0 4937.3 4949.1 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#4] prototype.html Cycles:180 Average:4782.38 Median:5477.51 stddev:1407.50 (25.7%) stddev-sans-first:1371.92 04:48:47 INFO - PID 5075 | Values: 369.2 391.3 391.5 393.5 398.9 5464.4 5553.7 5585.1 5654.3 5661.6 5375.3 5471.5 5472.9 5482.1 5483.7 4251.4 4255.6 4260.6 4275.6 4285.4 4033.7 4230.2 4280.9 4283.1 4283.9 4188.2 4201.9 4212.7 4214.1 4214.8 4203.8 4213.2 4216.0 4219.2 4225.6 3669.9 3670.0 3676.2 3696.3 3716.3 5142.6 5297.8 5325.9 5331.5 5333.4 4801.2 4806.4 4850.0 4851.0 4853.8 5535.6 5679.2 5710.4 5722.8 5733.7 4028.1 4034.6 4034.6 4043.7 4046.8 5928.8 6050.5 6081.2 6099.1 6129.1 4067.1 4075.0 4077.4 4086.2 4112.8 4139.7 4144.9 4147.6 4149.8 4153.6 4645.4 4777.7 4813.9 4823.2 4826.2 5770.5 5770.6 5781.2 5783.0 5785.9 1438.2 1459.9 1460.9 1461.8 1465.1 934.8 970.8 975.8 988.3 1000.9 5045.2 5064.8 5070.7 5093.2 5095.4 6013.2 6043.5 6049.5 6053.5 6062.2 4861.7 5014.8 5041.9 5052.9 5089.9 3164.4 3190.3 3196.0 3219.3 3222.8 5564.5 5578.6 5583.4 5590.3 5605.9 5879.3 6133.8 6137.8 6170.6 6174.9 5567.2 5574.4 5603.4 5607.3 5629.4 5806.3 5937.3 5986.1 6009.7 6014.9 5876.4 5900.6 5919.1 5944.9 5948.1 5385.5 5564.1 5564.2 5592.5 5608.5 4115.4 4146.7 4149.0 4155.1 4174.9 5900.4 5921.4 5992.5 6024.2 6032.8 5768.8 5789.4 5794.3 5794.4 5818.5 5803.6 5820.8 5822.8 5827.8 5838.6 5593.2 5688.2 5724.2 5763.5 5770.0 5866.2 5868.9 5875.7 5892.4 5900.8 5493.3 5720.9 5732.6 5734.4 5740.8 04:48:47 INFO - PID 5075 | 04:48:47 INFO - PID 5075 | [#5] yui.html Cycles:180 Average:13414.70 Median:24283.30 stddev:16676.75 (68.7%) stddev-sans-first:16695.71 04:48:47 INFO - PID 5075 | Values: 586.4 608.8 616.8 619.5 634.3 13326.0 13462.6 13784.4 13784.4 14165.2 12723.5 12783.2 12796.2 12801.8 12814.0 889.6 896.0 922.5 922.9 926.2 898.6 905.0 905.2 908.2 953.5 926.8 938.4 939.4 941.1 992.7 912.7 923.2 927.5 929.3 979.1 680.7 682.9 683.8 702.5 729.1 13594.4 13615.6 13635.4 13639.5 13897.2 12781.7 13199.0 13479.9 13652.7 13723.1 8601.9 8811.7 8857.7 9059.5 9166.3 2254.4 2257.7 2268.8 2343.5 2366.9 63742.7 63850.7 64135.4 65328.3 66491.3 10049.9 10231.8 10235.0 10456.1 10618.7 19719.1 21472.4 21757.8 22043.2 22075.2 6025.0 6082.3 6187.9 6224.5 6365.6 2818.4 2892.1 2922.7 2959.7 2984.4 3433.8 3461.5 3488.1 3492.5 3527.3 643.9 645.4 654.1 663.1 667.1 455.7 470.2 475.5 484.4 487.2 7277.3 7443.3 7685.5 7719.7 7737.4 451.9 458.4 475.8 477.1 482.9 3447.2 3448.1 3460.3 3486.1 3549.9 57172.0 58600.0 59595.7 63101.4 63192.7 49559.5 50708.0 50836.5 50994.0 52533.5 43577.6 46420.3 48089.5 48468.8 48514.8 8094.9 8254.3 8526.5 8543.0 8559.0 23702.8 24336.0 24409.3 25009.9 25391.2 29814.7 29933.9 29988.6 30101.5 30748.4 10541.2 10576.6 10580.0 10747.7 11447.7 10621.7 10624.8 10657.4 10757.7 10827.6 10315.7 10385.9 10666.2 11040.3 11045.2 10582.8 10591.8 10791.7 10840.7 10863.6 9609.4 9746.4 9855.5 10117.3 10168.4 8098.4 8102.3 8278.8 8326.4 8336.4 8908.2 9167.4 9174.4 9197.5 9222.4 04:48:47 INFO - PID 5075 | -------- Summary: end -------- 04:48:47 INFO - PID 5075 | 04:48:48 INFO - TEST-INFO | 5075: exit 0 04:48:48 INFO - TEST-OK | dromaeo_css | took 1122656ms 04:48:48 INFO - TEST-START | kraken 04:48:48 INFO - operating with platform_type : linux_ 04:48:48 INFO - Initialising browser for kraken test... 04:48:48 INFO - TEST-INFO | started process 5452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4WcX8/profile http://localhost:48868/getInfo.html) 04:48:53 INFO - PID 5452 | __metrics Screen width/height:1600/1200 04:48:53 INFO - PID 5452 | colorDepth:24 04:48:53 INFO - PID 5452 | Browser inner width/height: 1024/697 04:48:53 INFO - PID 5452 | __metrics 04:48:54 ERROR - PID 5452 | 1490960934303 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:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpd4WcX8/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpd4WcX8/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpd4WcX8/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpd4WcX8/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:48:54 ERROR - PID 5452 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:48:55 INFO - TEST-INFO | 5452: exit 0 04:48:55 INFO - Browser initialized. 04:48:55 INFO - Running cycle 1/1 for kraken test... 04:48:55 INFO - TEST-INFO | started process 5589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4WcX8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:07 INFO - PID 5589 | RSS: Main: 155430912 04:49:07 INFO - PID 5589 | 04:49:10 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48868/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:11 INFO - PID 5589 | RSS: Main: 162725888 04:49:11 INFO - PID 5589 | 04:49:13 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48868/tests/kraken/driver.html?testName=audio-dft) 04:49:14 INFO - PID 5589 | RSS: Main: 162054144 04:49:14 INFO - PID 5589 | 04:49:17 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48868/tests/kraken/driver.html?testName=audio-fft) 04:49:18 INFO - PID 5589 | RSS: Main: 158162944 04:49:18 INFO - PID 5589 | 04:49:20 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48868/tests/kraken/driver.html?testName=audio-oscillator) 04:49:21 INFO - PID 5589 | RSS: Main: 158715904 04:49:21 INFO - PID 5589 | 04:49:23 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:23 INFO - PID 5589 | RSS: Main: 158957568 04:49:23 INFO - PID 5589 | 04:49:27 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48868/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:27 INFO - PID 5589 | RSS: Main: 164044800 04:49:27 INFO - PID 5589 | 04:49:31 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48868/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:31 INFO - PID 5589 | RSS: Main: 161280000 04:49:31 INFO - PID 5589 | 04:49:34 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48868/tests/kraken/driver.html?testName=json-parse-financial) 04:49:35 INFO - PID 5589 | RSS: Main: 162496512 04:49:35 INFO - PID 5589 | 04:49:37 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:37 INFO - PID 5589 | RSS: Main: 162803712 04:49:37 INFO - PID 5589 | 04:49:39 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:40 INFO - PID 5589 | RSS: Main: 162709504 04:49:40 INFO - PID 5589 | 04:49:42 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:43 INFO - PID 5589 | RSS: Main: 163307520 04:49:43 INFO - PID 5589 | 04:49:45 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:46 INFO - PID 5589 | RSS: Main: 163942400 04:49:46 INFO - PID 5589 | 04:49:49 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:50 INFO - PID 5589 | RSS: Main: 163278848 04:49:50 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | Cycle 1(1): loaded http://localhost:48868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48868/tests/kraken/driver.html?testName=ai-astar) 04:49:52 INFO - PID 5589 | RSS: Main: 165126144 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | __start_tp_report 04:49:52 INFO - PID 5589 | _x_x_mozilla_page_load 04:49:52 INFO - PID 5589 | _x_x_mozilla_page_load_details 04:49:52 INFO - PID 5589 | |i|pagename|runs| 04:49:52 INFO - PID 5589 | |0;ai-astar;106;112;113;111;111;112;112;113;113;112 04:49:52 INFO - PID 5589 | |1;audio-beat-detection;155;127;127;182;128;130;125;124;150;127 04:49:52 INFO - PID 5589 | |2;audio-dft;168;167;170;172;170;170;165;165;167;168 04:49:52 INFO - PID 5589 | |3;audio-fft;75;77;81;124;76;78;76;75;93;75 04:49:52 INFO - PID 5589 | |4;audio-oscillator;85;85;110;84;84;86;102;85;85;104 04:49:52 INFO - PID 5589 | |5;imaging-gaussian-blur;115;115;116;117;115;120;115;114;116;116 04:49:52 INFO - PID 5589 | |6;imaging-darkroom;152;153;151;152;151;152;151;152;151;152 04:49:52 INFO - PID 5589 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 04:49:52 INFO - PID 5589 | |8;json-parse-financial;69;67;68;68;71;69;69;69;70;73 04:49:52 INFO - PID 5589 | |9;json-stringify-tinderbox;57;56;57;57;56;57;56;57;56;56 04:49:52 INFO - PID 5589 | |10;stanford-crypto-aes;83;83;83;87;84;84;83;84;92;100 04:49:52 INFO - PID 5589 | |11;stanford-crypto-ccm;145;139;136;145;137;135;141;139;188;134 04:49:52 INFO - PID 5589 | |12;stanford-crypto-pbkdf2;186;196;197;197;200;197;194;195;197;195 04:49:52 INFO - PID 5589 | |13;stanford-crypto-sha256-iterative;73;75;77;75;73;72;74;73;72;70 04:49:52 INFO - PID 5589 | __end_tp_report 04:49:52 INFO - PID 5589 | __start_cc_report 04:49:52 INFO - PID 5589 | _x_x_mozilla_cycle_collect,892 04:49:52 INFO - PID 5589 | __end_cc_report 04:49:52 INFO - PID 5589 | __startTimestamp1490960992681__endTimestamp 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | ------- Summary: start ------- 04:49:52 INFO - PID 5589 | Number of tests: 14 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 04:49:52 INFO - PID 5589 | Values: 106.0 112.0 113.0 111.0 111.0 112.0 112.0 113.0 113.0 112.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:129.00 stddev:19.03 (14.8%) stddev-sans-first:19.10 04:49:52 INFO - PID 5589 | Values: 155.0 127.0 127.0 182.0 128.0 130.0 125.0 124.0 150.0 127.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#2] audio-dft Cycles:10 Average:168.20 Median:169.00 stddev:2.30 (1.4%) stddev-sans-first:2.44 04:49:52 INFO - PID 5589 | Values: 168.0 167.0 170.0 172.0 170.0 170.0 165.0 165.0 167.0 168.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:15.41 (20.1%) stddev-sans-first:16.07 04:49:52 INFO - PID 5589 | Values: 75.0 77.0 81.0 124.0 76.0 78.0 76.0 75.0 93.0 75.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:85.00 stddev:10.10 (11.9%) stddev-sans-first:10.48 04:49:52 INFO - PID 5589 | Values: 85.0 85.0 110.0 84.0 84.0 86.0 102.0 85.0 85.0 104.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:1.66 (1.4%) stddev-sans-first:1.73 04:49:52 INFO - PID 5589 | Values: 115.0 115.0 116.0 117.0 115.0 120.0 115.0 114.0 116.0 116.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 04:49:52 INFO - PID 5589 | Values: 152.0 153.0 151.0 152.0 151.0 152.0 151.0 152.0 151.0 152.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:49:52 INFO - PID 5589 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 04:49:52 INFO - PID 5589 | Values: 69.0 67.0 68.0 68.0 71.0 69.0 69.0 69.0 70.0 73.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:49:52 INFO - PID 5589 | Values: 57.0 56.0 57.0 57.0 56.0 57.0 56.0 57.0 56.0 56.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.00 stddev:5.58 (6.6%) stddev-sans-first:5.79 04:49:52 INFO - PID 5589 | Values: 83.0 83.0 83.0 87.0 84.0 84.0 83.0 84.0 92.0 100.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.00 stddev:15.95 (11.4%) stddev-sans-first:16.92 04:49:52 INFO - PID 5589 | Values: 145.0 139.0 136.0 145.0 137.0 135.0 141.0 139.0 188.0 134.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:197.00 stddev:3.69 (1.9%) stddev-sans-first:1.74 04:49:52 INFO - PID 5589 | Values: 186.0 196.0 197.0 197.0 200.0 197.0 194.0 195.0 197.0 195.0 04:49:52 INFO - PID 5589 | 04:49:52 INFO - PID 5589 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:1.96 (2.7%) stddev-sans-first:2.07 04:49:52 INFO - PID 5589 | Values: 73.0 75.0 77.0 75.0 73.0 72.0 74.0 73.0 72.0 70.0 04:49:52 INFO - PID 5589 | -------- Summary: end -------- 04:49:52 INFO - PID 5589 | 04:49:53 INFO - TEST-INFO | 5589: exit 0 04:49:53 INFO - TEST-OK | kraken | took 65411ms 04:49:53 INFO - SUITE-END | took 1188s 04:49:54 INFO - Completed test suite (00:19:48) 04:49:54 INFO - javascript benchmark 04:49:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6654.170866148381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.757201851833, 2729.5359788835895, 2733.2346942856007, 2760.3375189954418, 2762.654668166479, 5191.662541934772, 5257.447967963361, 5274.498922602352, 5313.78744850206, 5348.839534813962, 5148.948510514893, 5247.396549396811, 5247.527722504974, 5358.437364076774, 5361.222622719703, 4777.402824646928, 4821.493743156971, 4842.564169224769, 4850.296706977486, 4871.318015477836, 4829.082474329866, 4840.00779840132, 4889.095517329305, 4893.902121957559, 4950.405951285833, 4727.598154156901, 4758.714477131383, 4782.665213435061, 4806.831760888387, 4814.903701925977, 4819.397575303087, 4833.854984350475, 4840.934994301283, 4868.732219727914, 4878.707277563358, 4708.882277943045, 4789.976050119762, 4796.52034796521, 4811.855644330676, 4834.299026641117, 5086.41506226785, 5177.559907407875, 5250.238715386286, 5270.8155214567305, 5330.093884039723, 5560.638558493725, 5577.274954255961, 5625.071863142576, 5625.915611265835, 5629.662220266797, 5693.202951586781, 5695.629784064023, 5704.030314846486, 5712.057510510761, 5714.7428365723645, 5107.208382700687, 5273.340832395912, 5287.7884884604955, 5297.443768404339, 5347.117725575315, 5769.1923130761725, 5813.651180929073, 5859.326177489644, 5864.47219750216, 5904.911426328608, 5437.782488700408, 5533.501984821305, 5534.944650553443, 5600.383957764642, 5607.915881261784, 5664.291963504562, 5690.118031705009, 5698.715064246771, 5705.115707065412, 5710.942890571041, 5653.321601407857, 5665.971670141623, 5666.093425051972, 5677.148427735872, 5679.630823996509, 5455.263539422127, 5526.949879522877, 5535.944640553624, 5538.501534861801, 5539.972300138474, 4761.262004389325, 4774.427068751703, 4774.928376074362, 4779.115863565252, 4793.23308270682, 4125.752454852658, 4140.772257525805, 4141.192467468814, 4144.5233798113, 4151.91696166075, 4823.927641085386, 4837.56461918422, 4838.250071238964, 4841.878953026132, 4845.0, 5642.0, 5659.6699775552715, 5666.320041595035, 5675.0, 5695.544356451557, 4849.199882019498, 4853.247746599282, 4857.587105096036, 4860.125177468019, 4862.246351815475, 5031.52200540948, 5034.89930201394, 5038.571721403649, 5039.571636410873, 5046.091703493333, 5312.574994000471, 5342.973285133549, 5351.411344752152, 5351.598630102758, 5399.676019438768, 5579.330480342385, 5673.687947162945, 5683.005474041944, 5722.542196624343, 5738.282714660668, 5222.582193424593, 5227.111391063604, 5232.319798426181, 5233.555147812326, 5235.633505654568, 5379.273798037371, 5484.698341591251, 5500.1749737539685, 5500.724963751876, 5533.667979921218, 5547.7780888764, 5579.776808927598, 5580.693061881636, 5582.8325150245555, 5583.441655834384, 5494.313210848644, 5501.449855014466, 5509.146082357241, 5545.72271386421, 5590.664560126405, 5468.972655136698, 5501.889962200654, 5511.255980442589, 5558.777648893999, 5569.10894256917, 5454.0, 5471.9179212311055, 5481.917771233514, 5485.040117979417, 5500.697461639648, 5397.892042159214, 5439.374471935778, 5568.610197286313, 5590.273264475592, 5637.408072152365, 5410.161424979135, 5435.211894275229, 5438.700871452108, 5448.0, 5448.427915068861], "value": 5158.925848714114, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.1164369882165, 644.3846126948764, 1064.7072055184824, 1073.8067147913378, 1188.3820413385045, 33906.15234619136, 35105.82447087764, 35109.297814043704, 35317.64682353172, 35432.82283588578, 32169.0, 32645.51031734526, 32659.67340326602, 32757.344853102924, 32763.344733105325, 6948.409385202264, 7082.610456424894, 7337.926620733804, 7352.264773522658, 7415.703371865119, 7492.325690687837, 7550.924490755105, 7567.091948966105, 7576.734814281501, 7590.7722768317035, 7511.436642251826, 7597.886031709529, 7616.657250423744, 7619.238076192391, 7636.083669959613, 7564.092308922965, 7579.0, 7592.164861865191, 7603.733869314603, 7629.427792915526, 7467.626618669099, 7470.887936680954, 7476.214997425246, 7498.775036748906, 7500.474966752329, 34428.827855860814, 34445.0, 34454.138646533786, 34574.82712586446, 34616.30767384663, 2582.57387531059, 2637.6175454559175, 2638.28766233116, 2668.4796464689393, 2674.2645772412548, 23070.7692923072, 23266.185683501164, 24057.51884962291, 24233.878830605736, 24682.50634987308, 2474.2453551666736, 2516.5218608464515, 2523.1421316752394, 2565.2560757380525, 2648.311439025848, 150501.0, 151275.24362378227, 152391.0, 152471.0, 152477.23761381232, 41125.0, 41166.79416602898, 41250.58749412528, 41360.0, 41952.370714439305, 45030.32454513185, 45297.547024529995, 45418.0, 45429.0, 45432.772836135606, 12710.42803073864, 12875.163114397534, 12898.67753306175, 12917.160384574972, 12919.483220671067, 10135.391876487287, 10142.391456512632, 10182.18542516597, 10184.898151018395, 10191.898081019242, 12904.870951290366, 12980.935095324463, 12986.155899866479, 13105.082644214814, 13180.143290686075, 5372.946270537244, 5411.594130440233, 5489.64317319373, 5515.365732940683, 5603.691796951207, 833.7457075591882, 844.4004756622744, 871.5685735560811, 891.7057371067532, 904.7918978634951, 18418.057191711145, 18846.905765471085, 19361.51596210106, 19910.203591856454, 20155.294564690164, 954.3224310739314, 956.1585804492141, 957.8850537935492, 969.2633598465217, 973.1387721866199, 9693.515324233902, 9945.403275803475, 10400.0, 10422.166226701846, 10532.15742740579, 253946.0, 257594.0, 257809.0, 258047.0, 258688.0, 43823.12353752907, 44108.3383749244, 44338.33492497615, 44526.55473445289, 44579.33131003038, 1184.8518935133109, 1232.4084439469104, 1232.9876701232872, 1244.104244943639, 1257.2330878164312, 18221.362252321105, 18292.908535457238, 18748.531286717942, 19054.333098341493, 19404.514887127934, 30383.696163038087, 30572.694273056986, 30655.386892262475, 30689.232769180948, 30697.386052279275, 228710.0, 229244.0, 229590.0, 229634.0, 230042.0, 29502.704972949996, 30221.244468888453, 30404.69595304107, 30517.0, 30780.692193078678, 35325.470117947734, 35427.645723543465, 35610.82194589114, 36347.0, 36620.45069323909, 26487.735122648526, 26585.33536661599, 27065.59401609017, 27282.454350912474, 27784.722152778213, 27040.594391083756, 27339.453210936066, 27606.585901211096, 28250.2937426566, 28254.0, 29679.0, 30003.84998075083, 30249.0, 30491.2377190572, 30647.62085706104, 26904.596431053942, 27022.864885675444, 27035.1889443317, 27112.593311099954, 27822.165335039983, 20621.484462888548, 21858.781412185675, 21920.23279185221, 22072.117115315206, 22173.33479995603], "value": 14874.322419932372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.50978825409516, 414.42601996235203, 421.7406295128495, 429.07320188393055, 436.3215200363435, 16152.353905843753, 17700.64598708025, 18156.81843181568, 18401.99999999998, 18437.078146092692, 16160.676786464264, 16532.09073500957, 16645.33418663252, 16731.83268167318, 16777.580560485992, 5662.235598194253, 5921.585489015771, 5925.88148237035, 6240.968795156041, 6498.967505162467, 6482.93517064828, 6521.054447105167, 6521.413072823445, 6524.804255872332, 6528.41244288014, 6160.260768707739, 6426.421622054014, 6444.162258906335, 6464.547481676284, 6467.029945508164, 6200.565960382775, 6368.872622547523, 6423.421892029716, 6440.291567927524, 6476.158099447089, 6245.281792593864, 6259.0, 6262.436380725711, 6271.843203919893, 6295.150154729099, 23129.0, 23371.182008629785, 23826.880865595733, 23949.521009579712, 24303.270901872973, 1563.7888885000493, 1606.3574570171909, 1618.304129224433, 1627.4222650958857, 1668.5661727950699, 15096.320665570076, 15250.923745381313, 15554.688906221812, 15850.048997060214, 15890.126043067627, 1730.723084306505, 1788.856891448681, 1799.7480352750626, 1814.5735752098246, 1834.7981722010568, 88978.5551072247, 94711.0, 94998.05001949961, 95382.0, 96076.0, 17550.0, 17637.0, 17681.557961051076, 18449.631007380045, 18560.164792584364, 32349.191270218435, 32425.351492970007, 32625.14871876885, 32705.50941735876, 32780.67219327824, 8670.566471676391, 8817.16236957488, 8896.0, 9022.819543609092, 9125.498097604695, 6975.581465112109, 7045.929540704527, 7131.786046418616, 7209.89185162223, 7218.169910460259, 9259.768505787275, 9349.672761453452, 9451.251518469106, 9558.665446709332, 9609.519524023772, 3835.9232815343535, 3963.3460479020637, 3965.8413663453716, 4060.7766572838186, 4065.3495440729935, 836.9665213391396, 849.180540778152, 861.4357595774777, 865.2472349056361, 877.5910126702244, 15736.68526629461, 16738.4141555045, 16790.58023549421, 16963.40628078036, 16977.830221697626, 866.4324867211986, 866.5147517390282, 873.4235404632911, 894.5303715549388, 903.2322525852973, 8752.69365572202, 9133.90866091344, 9220.492872892055, 9247.665349235795, 9298.814023719488, 414822.0, 415752.0, 474987.0, 479918.0, 483863.0, 91812.54093729489, 96976.51511742396, 97209.0, 98529.5073524642, 98928.0, 1046.7121541576128, 1079.9190060745475, 1102.2284400919548, 1108.141190577309, 1117.7596816684452, 17593.296268149643, 17739.911300443415, 18022.639547209244, 18366.173522191268, 18733.437996860117, 42772.572274276856, 42837.785811070746, 42845.0, 43389.783051085804, 43866.780666097744, 55150.17274740802, 55555.16667249914, 56003.71998139983, 56193.0, 56478.71760641171, 8074.111847696631, 8121.309688676529, 8154.714584989497, 8330.458520196411, 8431.578421079044, 12949.805752913526, 13030.54393096275, 13064.648363294698, 13160.276184809927, 13350.0, 10550.208734344802, 10920.726981825517, 11303.71740706456, 11448.885511144781, 11921.165518413627, 10203.28576999603, 10385.22110841705, 10498.107660848913, 10569.788604227719, 10593.788124237626, 10641.680749577525, 10900.291481053706, 10915.235933484897, 10967.945160274467, 12166.330851803235, 8209.753707388787, 8231.46495477792, 8437.029741579798, 8473.110323416198, 8666.003409607976, 10369.74075648115, 10969.341839489656, 10996.725081872697, 11242.145046067308, 11256.606018789304], "value": 9834.487364224444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.3789842976942, 1328.4752522753513, 1336.1181620130722, 1336.2984433172583, 1338.0967846703472, 9453.101955314243, 9828.803423931517, 9845.7538561536, 9930.106290433878, 10260.743481412968, 9870.950645246763, 10022.699319020441, 10085.142762865165, 10104.242181836373, 10113.292069555135, 2141.4004078857906, 2163.3834357208198, 2163.394249610104, 2176.4450065233345, 2178.880161591112, 2115.3019503563864, 2120.6818977153475, 2125.2880285104507, 2164.2641501889357, 2225.543763528473, 1984.6030793841217, 2041.9183232670675, 2054.465838881894, 2054.5479994401285, 2124.479502521884, 2142.967855482169, 2148.1622167354744, 2153.106460818766, 2159.6436587962967, 2166.068590506082, 1817.7455156278131, 1880.69908814589, 2073.906674199665, 2082.2607974169105, 2129.2441183379833, 9703.51482425883, 9803.068708472683, 9810.656627018092, 9821.165200957856, 9829.361091529028, 5346.625736198468, 5546.195801608744, 5554.611177217596, 5557.138643510262, 5558.360788509332, 3276.311974485361, 3317.7345812334956, 3414.197663549064, 3431.673990970854, 3466.739994500397, 1030.5362586835954, 1036.9792604147951, 1038.2317085356858, 1049.5486940615533, 1099.3239157917824, 14029.158250504901, 14040.438382464688, 14080.92959535206, 14095.2952352383, 14170.71658566823, 4675.434126455244, 4759.595434388047, 4805.13507568641, 4878.195097808822, 4905.288733133676, 10515.369077855354, 10525.9473702631, 10531.57873685044, 10543.0, 10558.947205263925, 5432.972835135799, 5433.049216387117, 5439.041944899833, 5456.208849716769, 5463.7814487420055, 4721.976390118028, 4797.520247975244, 4970.304157417964, 4992.600591952635, 5042.344495215599, 3680.9447858282147, 3702.740808143458, 3733.3093377724663, 3802.296575133609, 3838.980805095957, 1120.7422292872684, 1139.7606502634374, 1142.7485953090306, 1149.7930372532858, 1158.0503986730969, 647.5693663713578, 672.4015626092781, 676.2426082787211, 677.8712044711489, 682.7644462660375, 5006.6245031622775, 5048.116579598555, 5103.821366252238, 5107.412647545506, 5168.61235407346, 527.9630425870229, 537.9973100134553, 541.9891602167935, 543.5923057706719, 546.6528754241085, 3069.938601227963, 3105.891293804706, 3110.28463453407, 3150.054983504985, 3223.4520131577688, 11827.940860295816, 12386.876131238752, 12749.745005100032, 12788.744225115632, 12812.871871281355, 12584.937075314565, 12601.243925364324, 12615.810762838564, 12616.116871818884, 12648.494060237488, 8800.779980500538, 8935.0, 8986.86519702205, 8991.955040224757, 9007.729768106967, 5373.247745315581, 5432.212329212163, 5436.130219164915, 5456.236126942311, 5652.660840349592, 11162.776744465227, 11170.664880053611, 11194.496247668712, 11328.546858125912, 11629.185956983269, 11459.541618335174, 11504.769904602028, 11566.94216528912, 11596.710082248012, 11839.112066595211, 7372.668229929774, 7451.478396512192, 7458.142313634002, 7473.962630186814, 7549.282818132268, 8949.284057275272, 9049.457032578066, 9122.498262595622, 9144.3598948073, 9160.358774885693, 7293.854122917406, 7384.187739348775, 7430.517016394133, 7432.996545466292, 7454.776356709307, 6898.586084834926, 6968.128983877015, 6986.336298051677, 6989.126359205099, 6996.685149168198, 6198.597091189058, 6316.905246421215, 6325.683715814283, 6328.6202827830475, 6329.683515824282, 4658.906821863611, 4754.144254034307, 4779.187538118597, 4881.755912204447, 4973.950260497349, 4714.764261786965, 4807.158747219153, 4853.975730121327, 4937.259411088366, 4949.059678661043], "value": 4467.943762010304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.18226129123985, 391.3327776141678, 391.47737770076947, 393.527766679984, 398.93218152914, 5464.398916119224, 5553.694546799924, 5585.134304182848, 5654.293213348326, 5661.575381846357, 5375.3280839895015, 5471.534919531835, 5472.91790623141, 5482.095454250044, 5483.656504156477, 4251.3622956556455, 4255.616994470497, 4260.595243451882, 4275.572442755715, 4285.421468101813, 4033.6773058155277, 4230.17511585241, 4280.850170244042, 4283.079137985333, 4283.850065247717, 4188.183304255671, 4201.886500077482, 4212.705110642256, 4214.072903961123, 4214.789260536976, 4203.831846726127, 4213.157368526292, 4215.978920105411, 4219.198352313051, 4225.598568136023, 3669.9082522936874, 3670.0, 3676.246369494247, 3696.2977034363385, 3716.2939041582013, 5142.61430392722, 5297.841064768063, 5325.866853328659, 5331.520163185293, 5333.439988801198, 4801.15979703554, 4806.351142595775, 4849.951500484985, 4850.957044235506, 4853.757312134415, 5535.612507124503, 5679.176519404705, 5710.428957104298, 5722.771089156428, 5733.713314334266, 4028.133951200506, 4034.5561988181275, 4034.628226403037, 4043.65628921542, 4046.7976601170117, 5928.7628494860155, 6050.515958723292, 6081.1790408294755, 6099.090232362946, 6129.1419201311855, 4067.1255680028344, 4075.0, 4077.429159917614, 4086.1623367210245, 4112.814923328458, 4139.710220284612, 4144.91710165795, 4147.564505726916, 4149.813258403379, 4153.626173644326, 4645.39609850724, 4777.713337199779, 4813.9037219255415, 4823.204171311694, 4826.155422800995, 5770.538356931435, 5770.6249093808765, 5781.161731548902, 5783.0, 5785.942140578624, 1438.2305466575333, 1459.8540145985316, 1460.8685218330402, 1461.7515022445998, 1465.1428914085166, 934.7823941090024, 970.7961328121173, 975.7511834482303, 988.2538683294067, 1000.8740167311774, 5045.167547354646, 5064.772085256172, 5070.7464626768515, 5093.18509038552, 5095.414027386898, 6013.1581578579035, 6043.48630366415, 6049.516038716892, 6053.545984051126, 6062.242219722535, 4861.732604706775, 5014.84955451337, 5041.873953151201, 5052.9242061369105, 5089.949100508948, 3164.398764234788, 3190.3300306935803, 3196.0, 3219.2917558137174, 3222.758293128025, 5564.499195072382, 5578.609497335228, 5583.35791383996, 5590.273264475592, 5605.915911261334, 5879.2944846618675, 6133.76117717039, 6137.7851775187655, 6170.59346854727, 6174.919389106888, 5567.248421463131, 5574.386817450078, 5603.3836278009385, 5607.299087614048, 5629.352624448159, 5806.303243610793, 5937.2578427696535, 5986.132010858314, 6009.699515024318, 6014.939850601613, 5876.3536011037895, 5900.586958912835, 5919.052951527735, 5944.8811023780145, 5948.078047902582, 5385.515303622693, 5564.10974244119, 5564.221009058654, 5592.496675299242, 5608.495235428668, 4115.382692596135, 4146.688998325078, 4149.0, 4155.148194620156, 4174.937375939424, 5900.355978491531, 5921.407859214044, 5992.490638295793, 6024.156618073385, 6032.788852390146, 5768.807853015827, 5789.421057894346, 5794.275715535558, 5794.420557944172, 5818.4763371296785, 5803.564732645153, 5820.76716931335, 5822.82531524055, 5827.825165245049, 5838.649681019152, 5593.161025846156, 5688.232088668143, 5724.227229323988, 5763.452472015152, 5769.971150144391, 5866.208061911588, 5868.882622347614, 5875.676837773964, 5892.410758924073, 5900.763969441346, 5493.258410114583, 5720.942790572208, 5732.627379220337, 5734.397888221677, 5740.827775166752], "value": 4349.130755866552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3579380578268, 608.8203979825951, 616.7717944360586, 619.5136817598186, 634.2642534659796, 13326.0, 13462.59612211634, 13784.448622055119, 13784.448622055119, 14165.220912849789, 12723.491060357575, 12783.233006019645, 12796.168249063805, 12801.807972880391, 12814.03894707896, 889.5952341684518, 895.9686410975618, 922.4787994782927, 922.8754118194058, 926.2404828041009, 898.6001229452896, 905.0180554098811, 905.1853332001218, 908.2280061947325, 953.4994128082777, 926.7590426489128, 938.4134915677702, 939.3847030195199, 941.0777438110656, 992.6724181020282, 912.7124955639019, 923.2475532441039, 927.5130556457846, 929.330881765128, 979.1187930862245, 680.7379159023811, 682.9282925292822, 683.8119517132778, 702.4801646781345, 729.0740759235794, 13594.38825252866, 13615.59153225395, 13635.386407611582, 13639.454421823115, 13897.235652039133, 12781.680457988532, 13199.0, 13479.932600337033, 13652.726945461134, 13723.118145189523, 8601.913980860236, 8811.691590794355, 8857.689980850704, 9059.547022648907, 9166.266698664158, 2254.425121593983, 2257.6500642400456, 2268.8184945204343, 2343.5078633486987, 2366.8816559171973, 63742.68128659373, 63850.68074659644, 64135.358646413406, 65328.3467165327, 66491.335086649, 10049.949750251202, 10231.795364092824, 10235.029552826963, 10456.111230545488, 10618.681439556825, 19719.112639931238, 21472.355829325144, 21757.782422175893, 22043.228487002878, 22075.227367042397, 6025.0, 6082.300535438393, 6187.876242475125, 6224.502039836802, 6365.61806291624, 2818.365867679756, 2892.132360291946, 2922.7369536741794, 2959.689232630543, 2984.4031193761334, 3433.828308584561, 3461.480777883338, 3488.127968007998, 3492.4935884296633, 3527.294541091792, 643.9356064393617, 645.4255712415953, 654.1300070905684, 663.1081195791653, 667.1293961380445, 455.67191622032084, 470.1631096647972, 475.4840997517732, 484.41627838454576, 487.23747335419955, 7277.345038946521, 7443.292887175709, 7685.538867667958, 7719.65261563231, 7737.419693523008, 451.85766483557575, 458.35679090460405, 475.79540797456735, 477.0816178855689, 482.8816939849759, 3447.172678557178, 3448.1207292140843, 3460.2733425980323, 3486.111041684405, 3549.9290014200087, 57172.0, 58600.0, 59595.70202148962, 63101.36898631047, 63192.68403657952, 49559.504404955485, 50708.0, 50836.49163508391, 50994.0, 52533.474665252856, 43577.56422435862, 46420.30369544459, 48089.5191048092, 48468.75765621149, 48514.75742621264, 8094.910660009757, 8254.253804062808, 8526.488410695378, 8543.0, 8559.0, 23702.762972370056, 24336.0, 24409.26772196837, 25009.874555645405, 25391.238262852145, 29814.70185298206, 29933.850330748206, 29988.550171747003, 30101.548476772427, 30748.385032299677, 10541.156707463231, 10576.629817956335, 10580.001784315778, 10747.731306717395, 11447.713807154887, 10621.681349559525, 10624.787504249716, 10657.360558366523, 10757.731056723644, 10827.621033263798, 10315.742106447398, 10385.896141038493, 10666.200034997251, 11040.337579744919, 11045.171612128961, 10582.788344232918, 10591.788164236517, 10791.730206744895, 10840.67477975662, 10863.565457381615, 9609.423434593948, 9746.415215087118, 9855.45794981283, 10117.29178957466, 10168.440735759605, 8098.3521318293215, 8102.31130353903, 8278.793030174053, 8326.375521836007, 8336.374771892253, 8908.153725396078, 9167.358284919992, 9174.449533028039, 9197.494137822485, 9222.44665320083], "value": 5919.2810874351, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 113.0, 111.0, 111.0, 112.0, 112.0, 113.0, 113.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 127.0, 182.0, 128.0, 130.0, 125.0, 124.0, 150.0, 127.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 170.0, 172.0, 170.0, 170.0, 165.0, 165.0, 167.0, 168.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 81.0, 124.0, 76.0, 78.0, 76.0, 75.0, 93.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 84.0, 84.0, 86.0, 102.0, 85.0, 85.0, 104.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 117.0, 115.0, 120.0, 115.0, 114.0, 116.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 151.0, 152.0, 151.0, 152.0, 151.0, 152.0, 151.0, 152.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 71.0, 69.0, 69.0, 69.0, 70.0, 73.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 87.0, 84.0, 84.0, 83.0, 84.0, 92.0, 100.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 136.0, 145.0, 137.0, 135.0, 141.0, 139.0, 188.0, 134.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 196.0, 197.0, 197.0, 200.0, 197.0, 194.0, 195.0, 197.0, 195.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 77.0, 75.0, 73.0, 72.0, 74.0, 73.0, 72.0, 70.0], "value": 73.4, "unit": "score"}]}]} 04:49:54 INFO - Return code: 0 04:49:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:49:54 ERROR - # TBPL SUCCESS # 04:49:54 INFO - Running post-action listener: _resource_record_post_action 04:49:54 INFO - [mozharness: 2017-03-31 11:49:54.473197Z] Finished run-tests step (success) 04:49:54 INFO - Running post-run listener: _resource_record_post_run 04:49:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 12288; Write bytes: 364204032; Read time: 56; Write time: 441340 04:49:54 INFO - TinderboxPrint: CPU usage
13.4% 04:49:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 56 04:49:54 INFO - TinderboxPrint: I/O write bytes / time
364,204,032 / 441,340 04:49:54 INFO - TinderboxPrint: CPU idle
8,324.0 (86.6%) 04:49:54 INFO - TinderboxPrint: CPU user
1,222.0 (12.7%) 04:49:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:49:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 107749376; Read time: 40; Write time: 187972 04:49:54 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 256454656; Read time: 16; Write time: 253368 04:49:55 INFO - Running post-run listener: _upload_blobber_files 04:49:55 INFO - Blob upload gear active. 04:49:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:55 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 04:49:55 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'] 04:49:55 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 04:49:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:56 INFO - (blobuploader) - INFO - Done attempting. 04:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:01 INFO - (blobuploader) - INFO - Done attempting. 04:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:02 INFO - (blobuploader) - INFO - Done attempting. 04:50:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:50:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:03 INFO - (blobuploader) - INFO - Done attempting. 04:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:03 INFO - Return code: 0 04:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f43009abf36ca067b1e20853cacdfe25ebffb5c25b7c9446e7faee5c4bd849b0c1ff518c98ab12a67978cf5e2d2b37d563bd2c6d3b806818f57dcd181e20c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41dfcd1cf259d2070faae6801e29105d0c58f081cd429babc257f2369e8dbe4ee0e241585102946e680efde88c2c4effb79dca1a28815210bbb3c15eb76f6d98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f0e725d041fe2eca4b17202002b7d0e0c3949375e31032d45bca1201d2084f772955f4e8db7598343dd652165e0c1a1a60a67649fc43de34741f13df87946df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/296a754f991eb58439c4e663ae6109b30ebc580d86c8de8d1c77c7294db6f15691507ae9e4a60d8314a4aaeb5aa425ace7f86307a0eff096272920956af58841"} 04:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:03 INFO - Contents: 04:50:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f43009abf36ca067b1e20853cacdfe25ebffb5c25b7c9446e7faee5c4bd849b0c1ff518c98ab12a67978cf5e2d2b37d563bd2c6d3b806818f57dcd181e20c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41dfcd1cf259d2070faae6801e29105d0c58f081cd429babc257f2369e8dbe4ee0e241585102946e680efde88c2c4effb79dca1a28815210bbb3c15eb76f6d98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f0e725d041fe2eca4b17202002b7d0e0c3949375e31032d45bca1201d2084f772955f4e8db7598343dd652165e0c1a1a60a67649fc43de34741f13df87946df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/296a754f991eb58439c4e663ae6109b30ebc580d86c8de8d1c77c7294db6f15691507ae9e4a60d8314a4aaeb5aa425ace7f86307a0eff096272920956af58841"} 04:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:03 INFO - Copying logs to upload dir... 04:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.343318 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-31 04:50:02.795444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.799425) ========= 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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 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/6f43009abf36ca067b1e20853cacdfe25ebffb5c25b7c9446e7faee5c4bd849b0c1ff518c98ab12a67978cf5e2d2b37d563bd2c6d3b806818f57dcd181e20c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41dfcd1cf259d2070faae6801e29105d0c58f081cd429babc257f2369e8dbe4ee0e241585102946e680efde88c2c4effb79dca1a28815210bbb3c15eb76f6d98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f0e725d041fe2eca4b17202002b7d0e0c3949375e31032d45bca1201d2084f772955f4e8db7598343dd652165e0c1a1a60a67649fc43de34741f13df87946df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/296a754f991eb58439c4e663ae6109b30ebc580d86c8de8d1c77c7294db6f15691507ae9e4a60d8314a4aaeb5aa425ace7f86307a0eff096272920956af58841"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f43009abf36ca067b1e20853cacdfe25ebffb5c25b7c9446e7faee5c4bd849b0c1ff518c98ab12a67978cf5e2d2b37d563bd2c6d3b806818f57dcd181e20c32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/41dfcd1cf259d2070faae6801e29105d0c58f081cd429babc257f2369e8dbe4ee0e241585102946e680efde88c2c4effb79dca1a28815210bbb3c15eb76f6d98", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4f0e725d041fe2eca4b17202002b7d0e0c3949375e31032d45bca1201d2084f772955f4e8db7598343dd652165e0c1a1a60a67649fc43de34741f13df87946df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/296a754f991eb58439c4e663ae6109b30ebc580d86c8de8d1c77c7294db6f15691507ae9e4a60d8314a4aaeb5aa425ace7f86307a0eff096272920956af58841"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.848281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.848611) ========= 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=df17445c3590ff7897617a0e00000225-1490959737.97117-1439432726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:02.901512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:02.901821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:02.902145) ========= ========= Total master_lag: 0.26 =========