builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1490899241.95 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.954282) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.954638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.954906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.976660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:41.976908) ========= 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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 11:40:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 21.0M=0.001s 2017-03-30 11:40:42 (21.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.122239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.122523) ========= 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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:42.171936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 11:40:42.172324) ========= 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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 11:40:42,695 truncating revision to first 12 chars 2017-03-30 11:40:42,695 Setting DEBUG logging. 2017-03-30 11:40:42,695 attempt 1/10 2017-03-30 11:40:42,695 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-30 11:40:44,262 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.974152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 11:40:44.159904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:44.160223) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:44.160586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:44.160850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 11:40:44.170786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-30 11:40:44.171229) ========= /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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:44 INFO - MultiFileLogger online at 20170330 11:40:44 in /builds/slave/test 11:40:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:40:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:44 INFO - {'append_to_log': False, 11:40:44 INFO - 'base_work_dir': '/builds/slave/test', 11:40:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:40:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:44 INFO - 'branch': 'Firefox-Non-PGO', 11:40:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:44 INFO - 'config_files': ('talos/linux_config.py',), 11:40:44 INFO - 'default_actions': ('clobber', 11:40:44 INFO - 'read-buildbot-config', 11:40:44 INFO - 'download-and-extract', 11:40:44 INFO - 'populate-webroot', 11:40:44 INFO - 'create-virtualenv', 11:40:44 INFO - 'install', 11:40:44 INFO - 'run-tests'), 11:40:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:44 INFO - 'download_minidump_stackwalk': True, 11:40:44 INFO - 'download_symbols': 'ondemand', 11:40:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:44 INFO - 'gecko_profile': False, 11:40:44 INFO - 'gecko_profile_interval': 0, 11:40:44 INFO - 'installer_path': 'installer.exe', 11:40:44 INFO - 'log_level': 'info', 11:40:44 INFO - 'log_name': 'talos', 11:40:44 INFO - 'log_to_console': True, 11:40:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:44 INFO - 'opt_config_files': (), 11:40:44 INFO - 'pip_index': False, 11:40:44 INFO - 'suite': 'dromaeojs-e10s', 11:40:44 INFO - 'system_bits': '32', 11:40:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:44 INFO - 'title': 'talos-linux64-ix-070', 11:40:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:44 INFO - 'use_talos_json': True, 11:40:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:44 INFO - 'work_dir': 'build'} 11:40:44 INFO - [mozharness: 2017-03-30 18:40:44.790892Z] Running clobber step. 11:40:44 INFO - Running pre-action listener: _resource_record_pre_action 11:40:44 INFO - Running main action method: clobber 11:40:44 INFO - rmtree: /builds/slave/test/build 11:40:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:46 INFO - Running post-action listener: _resource_record_post_action 11:40:46 INFO - [mozharness: 2017-03-30 18:40:46.247321Z] Finished clobber step (success) 11:40:46 INFO - [mozharness: 2017-03-30 18:40:46.247444Z] Running read-buildbot-config step. 11:40:46 INFO - Running pre-action listener: _resource_record_pre_action 11:40:46 INFO - Running main action method: read_buildbot_config 11:40:46 INFO - Using buildbot properties: 11:40:46 INFO - { 11:40:46 INFO - "project": "", 11:40:46 INFO - "product": "firefox", 11:40:46 INFO - "who": "cbook@mozilla.com", 11:40:46 INFO - "installer_path": "public/build/target.tar.bz2", 11:40:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:40:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:40:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:40:46 INFO - "stage_platform": "linux64", 11:40:46 INFO - "basedir": "/builds/slave/test", 11:40:46 INFO - "buildnumber": 779, 11:40:46 INFO - "platform": "ubuntu64_hw", 11:40:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:40:46 INFO - "slavebuilddir": "test", 11:40:46 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 11:40:46 INFO - "branch": "mozilla-central", 11:40:46 INFO - "script_repo_revision": "production", 11:40:46 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 11:40:46 INFO - "slavename": "talos-linux64-ix-070", 11:40:46 INFO - "repo_path": "mozilla-central" 11:40:46 INFO - } 11:40:46 INFO - Finding installer, test and symbols from parent task. 11:40:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 11:40:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 11:40:47 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 11:40:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 11:40:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:40:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 11:40:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 11:40:47 INFO - Running post-action listener: _resource_record_post_action 11:40:47 INFO - [mozharness: 2017-03-30 18:40:47.648707Z] Finished read-buildbot-config step (success) 11:40:47 INFO - [mozharness: 2017-03-30 18:40:47.649013Z] Running download-and-extract step. 11:40:47 INFO - Running pre-action listener: _resource_record_pre_action 11:40:47 INFO - Running main action method: download_and_extract 11:40:47 INFO - mkdir: /builds/slave/test/build/tests 11:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:47 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 11:40:47 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 11:40:47 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 11:40:48 INFO - Downloaded 986 bytes. 11:40:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:40:48 INFO - Using the following test package requirements: 11:40:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:40:48 INFO - u'common': [u'target.common.tests.zip'], 11:40:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:40:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:40:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:40:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:40:48 INFO - u'mozbase': [u'target.common.tests.zip'], 11:40:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:40:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:40:48 INFO - u'web-platform': [u'target.common.tests.zip', 11:40:48 INFO - u'target.web-platform.tests.zip'], 11:40:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:40:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:40:48 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 11:40:48 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 11:40:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 11:40:49 INFO - Expected file size: 58227794 11:40:49 INFO - Obtained file size: 58227794 11:40:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:40:59 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 11:40:59 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 11:40:59 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 11:41:00 INFO - Expected file size: 58227794 11:41:00 INFO - Obtained file size: 58227794 11:41:11 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 11:41:11 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 11:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 11:41:11 INFO - Expected file size: 14404152 11:41:11 INFO - Obtained file size: 14404152 11:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:12 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:41:12 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 11:41:13 INFO - Downloaded 62478421 bytes. 11:41:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:13 INFO - mkdir: /builds/slave/test/properties 11:41:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:41:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:41:13 INFO - Contents: 11:41:13 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 11:41:13 INFO - Running post-action listener: _resource_record_post_action 11:41:13 INFO - Running post-action listener: set_extra_try_arguments 11:41:13 INFO - [mozharness: 2017-03-30 18:41:13.178794Z] Finished download-and-extract step (success) 11:41:13 INFO - [mozharness: 2017-03-30 18:41:13.178891Z] Running populate-webroot step. 11:41:13 INFO - Running pre-action listener: _resource_record_pre_action 11:41:13 INFO - Running main action method: populate_webroot 11:41:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:41:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:41:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:41:13 INFO - '--tppagecycles', 11:41:13 INFO - '7'], 11:41:13 INFO - 'tests': ['tsvgm']}}, 11:41:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:41:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:41:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:41:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:41:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['damp', 'tps']}, 11:41:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'tests': ['damp', 'tps']}, 11:41:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['dromaeo_dom']}, 11:41:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:41:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['basic_compositor_video']}, 11:41:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:41:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['a11yr', 11:41:13 INFO - 'ts_paint', 11:41:13 INFO - 'tpaint', 11:41:13 INFO - 'sessionrestore', 11:41:13 INFO - 'sessionrestore_no_auto_restore', 11:41:13 INFO - 'tabpaint']}, 11:41:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['tsvgx', 11:41:13 INFO - 'tsvgr_opacity', 11:41:13 INFO - 'tart', 11:41:13 INFO - 'tscrollx', 11:41:13 INFO - 'cart', 11:41:13 INFO - 'tsvg_static']}, 11:41:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:41:13 INFO - 'tsvgr_opacity', 11:41:13 INFO - 'tart', 11:41:13 INFO - 'tscrollx', 11:41:13 INFO - 'cart', 11:41:13 INFO - 'tsvg_static']}, 11:41:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'talos_options': ['--disable-e10s'], 11:41:13 INFO - 'tests': ['tp5o']}, 11:41:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:41:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'talos_options': ['--disable-e10s', 11:41:13 INFO - '--xperf_path', 11:41:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:13 INFO - 'tests': ['tp5n']}, 11:41:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:41:13 INFO - 'talos_options': ['--xperf_path', 11:41:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:13 INFO - 'tests': ['tp5n']}}, 11:41:13 INFO - 'talos.zip': {'path': '', 11:41:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:41:13 INFO - Running post-action listener: _resource_record_post_action 11:41:13 INFO - [mozharness: 2017-03-30 18:41:13.192060Z] Finished populate-webroot step (success) 11:41:13 INFO - [mozharness: 2017-03-30 18:41:13.192149Z] Running create-virtualenv step. 11:41:13 INFO - Running pre-action listener: _resource_record_pre_action 11:41:13 INFO - Running main action method: create_virtualenv 11:41:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:41:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:41:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:41:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:41:13 INFO - Using real prefix '/usr' 11:41:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:41:15 INFO - Installing pip.................done. 11:41:15 INFO - Return code: 0 11:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:41:15 INFO - Reading from file tmpfile_stdout 11:41:15 INFO - Output received: 11:41:15 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) 11:41:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:15 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:41:15 INFO - Using env: {'DISPLAY': ':0', 11:41:15 INFO - 'HOME': '/home/cltbld', 11:41:15 INFO - 'LANG': 'en_US.UTF-8', 11:41:15 INFO - 'LANGUAGE': 'en_US:en', 11:41:15 INFO - 'LOGNAME': 'cltbld', 11:41:15 INFO - 'MAIL': '/var/mail/cltbld', 11:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:15 INFO - 'MOZ_NO_REMOTE': '1', 11:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:15 INFO - 'NO_EM_RESTART': '1', 11:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:15 INFO - 'PWD': '/builds/slave/test', 11:41:15 INFO - 'SHELL': '/bin/bash', 11:41:15 INFO - 'SHLVL': '1', 11:41:15 INFO - 'TERM': 'linux', 11:41:15 INFO - 'TMOUT': '86400', 11:41:15 INFO - 'USER': 'cltbld', 11:41:15 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:15 INFO - '_': '/tools/buildbot/bin/python'} 11:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:41:16 INFO - Cleaning up... 11:41:16 INFO - Return code: 0 11:41:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:16 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:41:16 INFO - Using env: {'DISPLAY': ':0', 11:41:16 INFO - 'HOME': '/home/cltbld', 11:41:16 INFO - 'LANG': 'en_US.UTF-8', 11:41:16 INFO - 'LANGUAGE': 'en_US:en', 11:41:16 INFO - 'LOGNAME': 'cltbld', 11:41:16 INFO - 'MAIL': '/var/mail/cltbld', 11:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:16 INFO - 'MOZ_NO_REMOTE': '1', 11:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:16 INFO - 'NO_EM_RESTART': '1', 11:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:16 INFO - 'PWD': '/builds/slave/test', 11:41:16 INFO - 'SHELL': '/bin/bash', 11:41:16 INFO - 'SHLVL': '1', 11:41:16 INFO - 'TERM': 'linux', 11:41:16 INFO - 'TMOUT': '86400', 11:41:16 INFO - 'USER': 'cltbld', 11:41:16 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:16 INFO - '_': '/tools/buildbot/bin/python'} 11:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:16 INFO - Downloading/unpacking psutil>=3.1.1 11:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:18 INFO - Installing collected packages: psutil 11:41:18 INFO - Running setup.py install for psutil 11:41:18 INFO - building 'psutil._psutil_linux' extension 11:41:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:41:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:41:18 INFO - building 'psutil._psutil_posix' extension 11:41:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:41:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:41:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:19 INFO - Successfully installed psutil 11:41:19 INFO - Cleaning up... 11:41:19 INFO - Return code: 0 11:41:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:19 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:41:19 INFO - Using env: {'DISPLAY': ':0', 11:41:19 INFO - 'HOME': '/home/cltbld', 11:41:19 INFO - 'LANG': 'en_US.UTF-8', 11:41:19 INFO - 'LANGUAGE': 'en_US:en', 11:41:19 INFO - 'LOGNAME': 'cltbld', 11:41:19 INFO - 'MAIL': '/var/mail/cltbld', 11:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:19 INFO - 'MOZ_NO_REMOTE': '1', 11:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:19 INFO - 'NO_EM_RESTART': '1', 11:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:19 INFO - 'PWD': '/builds/slave/test', 11:41:19 INFO - 'SHELL': '/bin/bash', 11:41:19 INFO - 'SHLVL': '1', 11:41:19 INFO - 'TERM': 'linux', 11:41:19 INFO - 'TMOUT': '86400', 11:41:19 INFO - 'USER': 'cltbld', 11:41:19 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:19 INFO - '_': '/tools/buildbot/bin/python'} 11:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:41:21 INFO - Installing collected packages: mozsystemmonitor 11:41:21 INFO - Running setup.py install for mozsystemmonitor 11:41:21 INFO - Successfully installed mozsystemmonitor 11:41:21 INFO - Cleaning up... 11:41:21 INFO - Return code: 0 11:41:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:41:21 INFO - Using env: {'DISPLAY': ':0', 11:41:21 INFO - 'HOME': '/home/cltbld', 11:41:21 INFO - 'LANG': 'en_US.UTF-8', 11:41:21 INFO - 'LANGUAGE': 'en_US:en', 11:41:21 INFO - 'LOGNAME': 'cltbld', 11:41:21 INFO - 'MAIL': '/var/mail/cltbld', 11:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:21 INFO - 'MOZ_NO_REMOTE': '1', 11:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:21 INFO - 'NO_EM_RESTART': '1', 11:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:21 INFO - 'PWD': '/builds/slave/test', 11:41:21 INFO - 'SHELL': '/bin/bash', 11:41:21 INFO - 'SHLVL': '1', 11:41:21 INFO - 'TERM': 'linux', 11:41:21 INFO - 'TMOUT': '86400', 11:41:21 INFO - 'USER': 'cltbld', 11:41:21 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:21 INFO - '_': '/tools/buildbot/bin/python'} 11:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:21 INFO - Downloading/unpacking jsonschema==2.5.1 11:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:41:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:41:24 INFO - warning: no files found matching '*.txt' 11:41:24 INFO - no previously-included directories found matching 'build' 11:41:24 INFO - no previously-included directories found matching 'dist' 11:41:24 INFO - no previously-included directories found matching '.git*' 11:41:24 INFO - Installing collected packages: jsonschema, functools32 11:41:24 INFO - Running setup.py install for functools32 11:41:24 INFO - warning: no files found matching '*.txt' 11:41:24 INFO - no previously-included directories found matching 'build' 11:41:24 INFO - no previously-included directories found matching 'dist' 11:41:24 INFO - no previously-included directories found matching '.git*' 11:41:24 INFO - Successfully installed jsonschema functools32 11:41:24 INFO - Cleaning up... 11:41:24 INFO - Return code: 0 11:41:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:24 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:41:24 INFO - Using env: {'DISPLAY': ':0', 11:41:24 INFO - 'HOME': '/home/cltbld', 11:41:24 INFO - 'LANG': 'en_US.UTF-8', 11:41:24 INFO - 'LANGUAGE': 'en_US:en', 11:41:24 INFO - 'LOGNAME': 'cltbld', 11:41:24 INFO - 'MAIL': '/var/mail/cltbld', 11:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:24 INFO - 'MOZ_NO_REMOTE': '1', 11:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:24 INFO - 'NO_EM_RESTART': '1', 11:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:24 INFO - 'PWD': '/builds/slave/test', 11:41:24 INFO - 'SHELL': '/bin/bash', 11:41:24 INFO - 'SHLVL': '1', 11:41:24 INFO - 'TERM': 'linux', 11:41:24 INFO - 'TMOUT': '86400', 11:41:24 INFO - 'USER': 'cltbld', 11:41:24 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:24 INFO - '_': '/tools/buildbot/bin/python'} 11:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:41:24 INFO - Cleaning up... 11:41:24 INFO - Return code: 0 11:41:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:24 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:41:24 INFO - Using env: {'DISPLAY': ':0', 11:41:24 INFO - 'HOME': '/home/cltbld', 11:41:24 INFO - 'LANG': 'en_US.UTF-8', 11:41:24 INFO - 'LANGUAGE': 'en_US:en', 11:41:24 INFO - 'LOGNAME': 'cltbld', 11:41:24 INFO - 'MAIL': '/var/mail/cltbld', 11:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:24 INFO - 'MOZ_NO_REMOTE': '1', 11:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:24 INFO - 'NO_EM_RESTART': '1', 11:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:24 INFO - 'PWD': '/builds/slave/test', 11:41:24 INFO - 'SHELL': '/bin/bash', 11:41:24 INFO - 'SHLVL': '1', 11:41:24 INFO - 'TERM': 'linux', 11:41:24 INFO - 'TMOUT': '86400', 11:41:24 INFO - 'USER': 'cltbld', 11:41:24 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:24 INFO - '_': '/tools/buildbot/bin/python'} 11:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:27 INFO - Downloading docopt-0.6.1.tar.gz 11:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:27 INFO - Running setup.py install for blobuploader 11:41:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:27 INFO - Running setup.py install for requests 11:41:27 INFO - Running setup.py install for docopt 11:41:28 INFO - Successfully installed blobuploader requests docopt 11:41:28 INFO - Cleaning up... 11:41:28 INFO - Return code: 0 11:41:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:28 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:28 INFO - Using env: {'DISPLAY': ':0', 11:41:28 INFO - 'HOME': '/home/cltbld', 11:41:28 INFO - 'LANG': 'en_US.UTF-8', 11:41:28 INFO - 'LANGUAGE': 'en_US:en', 11:41:28 INFO - 'LOGNAME': 'cltbld', 11:41:28 INFO - 'MAIL': '/var/mail/cltbld', 11:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:28 INFO - 'MOZ_NO_REMOTE': '1', 11:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:28 INFO - 'NO_EM_RESTART': '1', 11:41:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:28 INFO - 'PWD': '/builds/slave/test', 11:41:28 INFO - 'SHELL': '/bin/bash', 11:41:28 INFO - 'SHLVL': '1', 11:41:28 INFO - 'TERM': 'linux', 11:41:28 INFO - 'TMOUT': '86400', 11:41:28 INFO - 'USER': 'cltbld', 11:41:28 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:28 INFO - '_': '/tools/buildbot/bin/python'} 11:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:28 INFO - Running setup.py (path:/tmp/pip-lblxc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:28 INFO - Running setup.py (path:/tmp/pip-1l1raL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:28 INFO - Running setup.py (path:/tmp/pip-gTJw1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:28 INFO - Running setup.py (path:/tmp/pip-_8CMn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:28 INFO - Running setup.py (path:/tmp/pip-KUxhUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:28 INFO - Running setup.py (path:/tmp/pip-SqfP4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:28 INFO - Running setup.py (path:/tmp/pip-7iS8Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:28 INFO - Running setup.py (path:/tmp/pip-mfFqcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:28 INFO - Running setup.py (path:/tmp/pip-mT5ULL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:28 INFO - Running setup.py (path:/tmp/pip-n2h2Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:29 INFO - Running setup.py (path:/tmp/pip-2uwhon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:29 INFO - Running setup.py (path:/tmp/pip-YEuOFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:29 INFO - Running setup.py (path:/tmp/pip-6ptzbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:29 INFO - Running setup.py (path:/tmp/pip-nDpmCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:29 INFO - Running setup.py (path:/tmp/pip-MZBQD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:29 INFO - Running setup.py (path:/tmp/pip-BLHJLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:29 INFO - Running setup.py (path:/tmp/pip-z9K2t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:29 INFO - Running setup.py install for manifestparser 11:41:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozcrash 11:41:29 INFO - Running setup.py install for mozdebug 11:41:29 INFO - Running setup.py install for mozdevice 11:41:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:29 INFO - Running setup.py install for mozfile 11:41:30 INFO - Running setup.py install for mozhttpd 11:41:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozinfo 11:41:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozInstall 11:41:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozleak 11:41:30 INFO - Running setup.py install for mozlog 11:41:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for moznetwork 11:41:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozprocess 11:41:30 INFO - Running setup.py install for mozprofile 11:41:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:30 INFO - Running setup.py install for mozrunner 11:41:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:31 INFO - Running setup.py install for mozscreenshot 11:41:31 INFO - Running setup.py install for moztest 11:41:31 INFO - Running setup.py install for mozversion 11:41:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:31 INFO - Cleaning up... 11:41:31 INFO - Return code: 0 11:41:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:31 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:31 INFO - Using env: {'DISPLAY': ':0', 11:41:31 INFO - 'HOME': '/home/cltbld', 11:41:31 INFO - 'LANG': 'en_US.UTF-8', 11:41:31 INFO - 'LANGUAGE': 'en_US:en', 11:41:31 INFO - 'LOGNAME': 'cltbld', 11:41:31 INFO - 'MAIL': '/var/mail/cltbld', 11:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:31 INFO - 'MOZ_NO_REMOTE': '1', 11:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:31 INFO - 'NO_EM_RESTART': '1', 11:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:31 INFO - 'PWD': '/builds/slave/test', 11:41:31 INFO - 'SHELL': '/bin/bash', 11:41:31 INFO - 'SHLVL': '1', 11:41:31 INFO - 'TERM': 'linux', 11:41:31 INFO - 'TMOUT': '86400', 11:41:31 INFO - 'USER': 'cltbld', 11:41:31 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:31 INFO - '_': '/tools/buildbot/bin/python'} 11:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:31 INFO - Running setup.py (path:/tmp/pip-DJIiV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:31 INFO - Running setup.py (path:/tmp/pip-Lrlc5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:31 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)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:31 INFO - Running setup.py (path:/tmp/pip-IANKBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:31 INFO - Running setup.py (path:/tmp/pip-zkZqU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:31 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)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:31 INFO - Running setup.py (path:/tmp/pip-piQc5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:31 INFO - Running setup.py (path:/tmp/pip-v9_dnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:32 INFO - Running setup.py (path:/tmp/pip-QFFdwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:32 INFO - Running setup.py (path:/tmp/pip-EKPNPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:32 INFO - Running setup.py (path:/tmp/pip-MJ7YNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:32 INFO - Running setup.py (path:/tmp/pip-4cR5k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:32 INFO - Running setup.py (path:/tmp/pip-va6t8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:32 INFO - Running setup.py (path:/tmp/pip-Vms0It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:32 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)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:32 INFO - Running setup.py (path:/tmp/pip-iQq4tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:32 INFO - Running setup.py (path:/tmp/pip-efMiwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:32 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)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:32 INFO - Running setup.py (path:/tmp/pip-VpdNv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:32 INFO - Running setup.py (path:/tmp/pip-ng4kPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:32 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)) 11:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:32 INFO - Running setup.py (path:/tmp/pip-JFQoDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:41:32 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)) 11:41:32 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)) 11:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:32 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)) 11:41:32 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)) 11:41:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:34 INFO - Downloading blessings-1.6.tar.gz 11:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:34 INFO - Installing collected packages: blessings 11:41:34 INFO - Running setup.py install for blessings 11:41:35 INFO - Successfully installed blessings 11:41:35 INFO - Cleaning up... 11:41:35 INFO - Return code: 0 11:41:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:35 INFO - Reading from file tmpfile_stdout 11:41:35 INFO - Current package versions: 11:41:35 INFO - argparse == 1.2.1 11:41:35 INFO - blessings == 1.6 11:41:35 INFO - blobuploader == 1.2.4 11:41:35 INFO - docopt == 0.6.1 11:41:35 INFO - functools32 == 3.2.3-2 11:41:35 INFO - jsonschema == 2.5.1 11:41:35 INFO - manifestparser == 1.1 11:41:35 INFO - mozInstall == 1.12 11:41:35 INFO - mozcrash == 1.0 11:41:35 INFO - mozdebug == 0.1 11:41:35 INFO - mozdevice == 0.49 11:41:35 INFO - mozfile == 1.2 11:41:35 INFO - mozhttpd == 0.7 11:41:35 INFO - mozinfo == 0.9 11:41:35 INFO - mozleak == 0.1 11:41:35 INFO - mozlog == 3.4 11:41:35 INFO - moznetwork == 0.27 11:41:35 INFO - mozprocess == 0.25 11:41:35 INFO - mozprofile == 0.28 11:41:35 INFO - mozrunner == 6.13 11:41:35 INFO - mozscreenshot == 0.1 11:41:35 INFO - mozsystemmonitor == 0.3 11:41:35 INFO - moztest == 0.8 11:41:35 INFO - mozversion == 1.4 11:41:35 INFO - psutil == 3.1.1 11:41:35 INFO - requests == 1.2.3 11:41:35 INFO - wsgiref == 0.1.2 11:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:35 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:35 INFO - Using env: {'DISPLAY': ':0', 11:41:35 INFO - 'HOME': '/home/cltbld', 11:41:35 INFO - 'LANG': 'en_US.UTF-8', 11:41:35 INFO - 'LANGUAGE': 'en_US:en', 11:41:35 INFO - 'LOGNAME': 'cltbld', 11:41:35 INFO - 'MAIL': '/var/mail/cltbld', 11:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:35 INFO - 'MOZ_NO_REMOTE': '1', 11:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:35 INFO - 'NO_EM_RESTART': '1', 11:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:35 INFO - 'PWD': '/builds/slave/test', 11:41:35 INFO - 'SHELL': '/bin/bash', 11:41:35 INFO - 'SHLVL': '1', 11:41:35 INFO - 'TERM': 'linux', 11:41:35 INFO - 'TMOUT': '86400', 11:41:35 INFO - 'USER': 'cltbld', 11:41:35 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:35 INFO - '_': '/tools/buildbot/bin/python'} 11:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:35 INFO - Cleaning up... 11:41:35 INFO - Return code: 0 11:41:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe91b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, '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': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41: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'] in /builds/slave/test/build 11:41: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 11:41:35 INFO - Using env: {'DISPLAY': ':0', 11:41:35 INFO - 'HOME': '/home/cltbld', 11:41:35 INFO - 'LANG': 'en_US.UTF-8', 11:41:35 INFO - 'LANGUAGE': 'en_US:en', 11:41:35 INFO - 'LOGNAME': 'cltbld', 11:41:35 INFO - 'MAIL': '/var/mail/cltbld', 11:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:35 INFO - 'MOZ_NO_REMOTE': '1', 11:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:35 INFO - 'NO_EM_RESTART': '1', 11:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:35 INFO - 'PWD': '/builds/slave/test', 11:41:35 INFO - 'SHELL': '/bin/bash', 11:41:35 INFO - 'SHLVL': '1', 11:41:35 INFO - 'TERM': 'linux', 11:41:35 INFO - 'TMOUT': '86400', 11:41:35 INFO - 'USER': 'cltbld', 11:41:35 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:35 INFO - '_': '/tools/buildbot/bin/python'} 11:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:35 INFO - Cleaning up... 11:41:35 INFO - Return code: 0 11:41:35 INFO - Running post-action listener: _resource_record_post_action 11:41:35 INFO - Running post-action listener: _start_resource_monitoring 11:41:35 INFO - Starting resource monitoring. 11:41:35 INFO - [mozharness: 2017-03-30 18:41:35.816163Z] Finished create-virtualenv step (success) 11:41:35 INFO - [mozharness: 2017-03-30 18:41:35.816637Z] Running install step. 11:41:35 INFO - Running pre-action listener: _resource_record_pre_action 11:41:35 INFO - Running main action method: install 11:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:36 INFO - Reading from file tmpfile_stdout 11:41:36 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:36 INFO - Reading from file tmpfile_stdout 11:41:36 INFO - Output received: 11:41:36 INFO - Usage: mozinstall [options] installer 11:41:36 INFO - Options: 11:41:36 INFO - -h, --help show this help message and exit 11:41:36 INFO - -d DEST, --destination=DEST 11:41:36 INFO - Directory to install application into. [default: 11:41:36 INFO - "/builds/slave/test"] 11:41:36 INFO - --app=APP Application being installed. [default: firefox] 11:41:36 INFO - mkdir: /builds/slave/test/build/application 11:41:36 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'] 11:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:41:51 INFO - Reading from file tmpfile_stdout 11:41:51 INFO - Output received: 11:41:51 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:51 INFO - Running post-action listener: _resource_record_post_action 11:41:51 INFO - [mozharness: 2017-03-30 18:41:51.765012Z] Finished install step (success) 11:41:51 INFO - [mozharness: 2017-03-30 18:41:51.765281Z] Running run-tests step. 11:41:51 INFO - Running pre-action listener: _resource_record_pre_action 11:41:51 INFO - Running main action method: run_tests 11:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:51 INFO - Python 2.7.3 11:41:51 INFO - Return code: 0 11:41:51 INFO - grabbing minidump binary from tooltool 11:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:51 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 0xe8f290>, '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 0xe8fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe90040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:41:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:41:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:51 INFO - Return code: 0 11:41:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:51 INFO - ENV: RUST_BACKTRACE is now 1 11:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:51 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-070', '--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 11:41:51 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-070 --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 11:41:51 INFO - Using env: {'DISPLAY': ':0', 11:41:51 INFO - 'HOME': '/home/cltbld', 11:41:51 INFO - 'LANG': 'en_US.UTF-8', 11:41:51 INFO - 'LANGUAGE': 'en_US:en', 11:41:51 INFO - 'LOGNAME': 'cltbld', 11:41:51 INFO - 'MAIL': '/var/mail/cltbld', 11:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:51 INFO - 'MOZ_NO_REMOTE': '1', 11:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:51 INFO - 'NO_EM_RESTART': '1', 11:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:51 INFO - 'PWD': '/builds/slave/test', 11:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:51 INFO - 'RUST_BACKTRACE': '1', 11:41:51 INFO - 'SHELL': '/bin/bash', 11:41:51 INFO - 'SHLVL': '1', 11:41:51 INFO - 'TERM': 'linux', 11:41:51 INFO - 'TMOUT': '86400', 11:41:51 INFO - 'USER': 'cltbld', 11:41:51 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537', 11:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:51 INFO - '_': '/tools/buildbot/bin/python'} 11:41:51 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-070', '--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 11:41:52 INFO - mozversion application_buildid: 20170330114804 11:41:52 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 11:41:52 INFO - mozversion application_display_name: Nightly 11:41:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:52 INFO - mozversion application_name: Firefox 11:41:52 INFO - mozversion application_remotingname: firefox 11:41:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:41:52 INFO - mozversion application_vendor: Mozilla 11:41:52 INFO - mozversion application_version: 55.0a1 11:41:52 INFO - mozversion platform_buildid: 20170330114804 11:41:52 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 11:41:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:41:52 INFO - mozversion platform_version: 55.0a1 11:41:52 INFO - using testdate: 1490899312 11:41:52 INFO - actual date: 1490899312 11:41:52 INFO - starting webserver on 'localhost:33222' 11:41:52 INFO - SUITE-START | Running 2 tests 11:41:52 INFO - TEST-START | dromaeo_css 11:41:52 INFO - operating with platform_type : linux_ 11:41:52 INFO - Initialising browser for dromaeo_css test... 11:41:52 INFO - TEST-INFO | started process 21732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVpT19K/profile http://localhost:33222/getInfo.html) 11:41:56 INFO - PID 21732 | __metrics Screen width/height:1600/1200 11:41:56 INFO - PID 21732 | colorDepth:24 11:41:56 INFO - PID 21732 | Browser inner width/height: 1024/697 11:41:56 INFO - PID 21732 | __metrics 11:41:57 ERROR - PID 21732 | 1490899317155 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/tmpVpT19K/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpVpT19K/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpVpT19K/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpVpT19K/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:41:57 ERROR - PID 21732 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:41:58 INFO - TEST-INFO | 21732: exit 0 11:41:58 INFO - Browser initialized. 11:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:58 INFO - TEST-INFO | started process 21861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVpT19K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:10 INFO - PID 21861 | RSS: Main: 155754496 11:42:10 INFO - PID 21861 | 11:45:15 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33222/tests/dromaeo/cssquery-ext.html) 11:45:17 INFO - PID 21861 | RSS: Main: 165380096 11:45:17 INFO - PID 21861 | 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 21861 | 11:46:58 ERROR - PID 21861 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 21861 | Full stack: 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 21861 | 11:46:58 ERROR - PID 21861 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 21861 | Full stack: 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 21861 | 11:46:58 ERROR - PID 21861 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 21861 | Full stack: 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | ************************* 11:46:58 INFO - PID 21861 | A coding exception was thrown and uncaught in a Task. 11:46:58 INFO - PID 21861 | 11:46:58 ERROR - PID 21861 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:46:58 INFO - PID 21861 | Full stack: 11:46:58 INFO - PID 21861 | ************************* 11:48:19 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-ext.html (next: http://localhost:33222/tests/dromaeo/cssquery-jquery.html) 11:48:19 INFO - PID 21861 | RSS: Main: 161529856 11:48:19 INFO - PID 21861 | 11:51:21 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33222/tests/dromaeo/cssquery-mootools.html) 11:51:22 INFO - PID 21861 | RSS: Main: 169590784 11:51:22 INFO - PID 21861 | 11:54:24 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33222/tests/dromaeo/cssquery-prototype.html) 11:54:24 INFO - PID 21861 | RSS: Main: 160964608 11:54:24 INFO - PID 21861 | 11:57:27 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33222/tests/dromaeo/cssquery-yui.html) 11:57:28 INFO - PID 21861 | RSS: Main: 168620032 11:57:28 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | Cycle 1(1): loaded http://localhost:33222/tests/dromaeo/cssquery-yui.html (next: http://localhost:33222/tests/dromaeo/cssquery-dojo.html) 12:00:31 INFO - PID 21861 | RSS: Main: 162287616 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | __start_tp_report 12:00:31 INFO - PID 21861 | _x_x_mozilla_page_load 12:00:31 INFO - PID 21861 | _x_x_mozilla_page_load_details 12:00:31 INFO - PID 21861 | |i|pagename|runs| 12:00:31 INFO - PID 21861 | |0;dojo.html;2662.134806187989;2674.384891474962;2689.4755522673076;2710.715374885637;2718.6329845470864;5071.087204303224;5101.795928162874;5110.310108135401;5185.792568297264;5197.116490196666;5181.5854731621475;5211.140161873286;5222.268882356473;5294.814681486139;5316.7873285068645;4771.475137734847;4797.90404191916;4802.783874725646;4829.710217386951;4840.806367745286;4829.782659780319;4845.612351011928;4900.431861804224;4906.092372911005;4954.900901981958;4672.065586882637;4720.787564559569;4722.456917454502;4827.9034419311765;4832.879178020543;4759.428868535798;4778.068276686047;4784.067106914154;4822.9758851205515;4840.6127509799135;4676.5089665584965;4742.170120228946;4751.857444276678;4778.4265888093305;4787.066522028206;5021.824236151754;5072;5175.094358487249;5183.092958732244;5254.290670759475;5596.244506991545;5653.349864765522;5706.629069110494;5708.5433165347085;5714.685692286923;5681.261436013292;5701.515371193412;5705.5720820938595;5710.71446427677;5715.3998830122655;5140.254663073908;5290.603204759658;5292.338457692788;5292.364916210041;5370.543503802221;5742.08126699726;5751.8562035949435;5811.4479124483105;5834.154047663065;5856.502197313276;5335.839924802262;5409.621326507186;5469.644473109235;5562.332520097614;5562.638428502134;5595.878717690139;5648.237487939158;5656.179853921159;5657.12314591239;5671.546276297886;5435.918461223085;5626.971865140648;5629.183768353566;5633.63381380209;5635.718214089279;5449.618526703092;5593.636413633101;5672.858178545487;5673.461021203062;5686.658800471902;4756.072565849626;4762.904741905142;4763.76181190939;4766.523347665206;4800.807967681323;4061.431399604058;4073.6130067644117;4077.918441631151;4078.1435898461064;4105.158442519277;4646.140464014168;4712.010477799632;4774.809007639656;4834.685745426536;4841.176999910023;5667.489925906688;5675.659460432387;5677.120046392815;5698.487136157766;5745.626534275259;4827.131116399011;4841.830535931296;4845.4850692601885;4849.854504364875;4868.391451068616;4909.386326709161;4976.2286845539;4990.8253211137435;4995.275685025578;5062.215356619729;5163.948360516347;5230.503102205284;5233.528982391603;5236.738163091906;5240.4759524047295;5593.916091258553;5602.775888964396;5611.074172761612;5618.4662457066515;5620;5177.92233116496;5210.869728256824;5305.708186049805;5314.9468505316;5324.547413469899;5566.248556444828;5589.077802162597;5622.8313150605545;5624.6625202487985;5625.803096891589;5494.587905906993;5680.801171958961;5688.943110568841;5707.828765137053;5711.171880077449;5417.485338892799;5425.945740542544;5478.753456094406;5498.120300752021;5509;5495.450454954473;5511.944880551143;5522.502974732293;5525.171224316385;5531.032069387921;5366.785328586813;5405.621606487508;5449.809256675997;5451.400345961862;5503.587230957774;5314.229436731575;5405.837824865261;5422.891542169214;5426.104692725656;5427.294451721251;5228.738563071755;5243.58051355883;5248.448912864094;5256.421793602777;5281.445448228034 12:00:31 INFO - PID 21861 | |1;ext.html;595.309441048384;658.739797779877;679.3071067511139;1172.0213621625942;1175.2713317743;36116.63883361166;36856.262874742526;36906.815465922635;36939.4459083114;36997;33044;33301.33397332052;33408.16479588012;33439.66560334396;33501.83249083757;6900.585964842113;7290.854182916339;7477.77566672998;7477.962610186969;7478.738244161455;7462.104547454313;7520.661570229353;7521.924780752177;7537.246275372474;7552.2825331593685;7539.849203015937;7578.393728501706;7598.924010759904;7622.199669034727;7630.618469076524;7494.999999999945;7522.134954480222;7531.322181003736;7567.621618919087;7587.317141457295;7276.708931642728;7340.229275926058;7383.926160738378;7406.962965185139;7419.740309089156;33697.32605347904;33802;33870.32259354824;33876.49185262223;34031.82984085064;2515.635232891239;2520.6345079963485;2546.719860815309;2574.7039090504645;2610.1386542441137;24054.759452405426;24175.516489670284;24424.145154919494;24579.262622121365;24837.254882353558;2602.9869850650816;2607.2699644099685;2625.934351641205;2627.7240889706686;2629.855357955312;161420;161757.19121404318;162370;162454;163468;43761.78119109384;43786.34320485195;43796.124077518274;43800.56199437965;43835.561644383786;45119;45378.31932521015;45400.77299613547;45441.31838022432;45478.545214547434;12734.108612397229;13009;13117.60647180586;13121.278329691768;13123.868761312455;10440.530176142092;10445.05994460487;10445.68662940113;10448;10453.536504889322;13164.736705265841;13357.465701371837;13365.53220637273;13425.180712050384;13569.525066622818;5531.225628412026;5569.888602227933;5584.5811564132855;5587.888242235133;5605.607607467519;840.8864803251482;853.7694822397917;857.0957639690187;863.1239292118505;872.1627237851733;20101.899490502456;20713.482162946046;20792.27227047046;20890.373288801362;21181.470463238544;925.6760133953197;934.1825902335456;947.3984020147257;962.9614815407446;993.7813680990171;10548.525316360781;10629.73425664349;10967.50646220922;11011;11017.338959662446;230103;230996;231503;231570;231887;42922.356164657554;43108;43372;43414;43445;1207.4204381896739;1238.8637249902504;1242.6644805902356;1246.3145270101409;1247.25788156047;22518.774812252323;23618;23647;23767.1681491147;23968;28956.710432896245;28973.7102628971;28998.275043123245;29013.274668133465;29023;174137;174700.12649937178;174907;175565;175998;26881.865590672704;28991.855040724662;29311.801614879398;29607;29644;35000;35380.16227322463;35557.64442355647;36019.279614408086;36084;26532.002605759615;27445.31386715348;28380.43239135247;28530.572041418982;28630.284242894093;26783.598246026715;26931.596026060015;27401.86299068492;28230.85884570564;28231;29637;29961.850190749778;30064.3987120252;30751.53872691956;30930.53604195984;26681.866590666923;26830.865845670647;27185.456290874467;27509.17472475829;28223.435531288847;20918.686219707022;22166.778332216472;22336.441588960406;22353.776462235168;22416.439589010406 12:00:31 INFO - PID 21861 | |2;jquery.html;404.5529689692891;405.97970101494917;424.5627004185688;429.8495526565702;434.99565004349967;14896.47862324819;17821.28714851406;18409;18680.15939282732;18737.99999999998;16720.83279167208;16843.57891052724;17141.400050998218;17688.38090666827;17944.461666150004;5678.154599755076;5699.287589051369;5709.1150871614755;5873.324567674708;5892.941070589303;5727.942720572803;5801.7389217485315;5810.273715785527;5810.360860305363;5820.970895145519;5557.666540007593;5712.714639206166;5730.541556675456;5793.4785869271755;5815.534757219433;5720.485156335929;5759.539236861041;5771.365149833515;5774;5783.652980821164;5005.674631148963;5088.643794934356;5131.102057139986;5136.6661167024395;5139.922901156486;21501.892490537448;22131.336059918227;22174.445638858997;22218.333449996528;22483.66274505884;1548.95353139406;1551.8060242469692;1565.5068653374265;1567.357383472782;1583.2163079275833;13852.168869867739;14172.574822755334;14183.57449276513;14832.184229867353;14940.775888361683;1549.1170033081034;1596.6407558299406;1732.6274850906989;1755.8244175582468;1766.187553725288;76503;78600;78949.60525197395;80096;80472;10937.781244375068;10978.176636752116;10979.008818780276;10989.340639561491;11074.39090850011;14373.6406589834;15552.611184720246;15600.375984960701;15602.375904963674;15636.765448518281;7728.613569321511;7852.607369631495;7975.162607926084;8031.277185053374;8069.152738962324;7229.602371869492;7243;7282;7453.440991925628;7467.290607392289;6988.44092472601;7035.155781306276;7067.469939754436;7081.065485185075;7264.418846492268;2030.9086091125935;2041.0917141871726;2053.1376821734907;2053.1992522916075;2139.112268408624;819.397742659145;835.9247667709935;839.202757380491;855.1363123245567;869.2437579306044;16060.43788467398;16897.577560561083;16917.915410423117;16930.830691692925;17226.138693065295;858.742377286824;859.3898332184219;880.9823803524022;885.5660726244223;885.9158379953894;8611.526366049802;9411;9475.099865512766;9621.615135394646;9625.422474651543;424741;442153;446339;454317;454357;87755;88943.55528222446;89060.5546972274;89668.5516572413;90333.54833225792;997.9501024948723;1020.4897551224387;1047.402980301221;1048.3866937841449;1048.9475526223657;14238.430462781787;14267.357968891218;14293.499727509487;14567.708645827237;15022.624434389229;43084.569154308054;43703.344449833916;43932.78033609811;44402.77798610986;45439.09121817479;53742.46257537375;56124;57234.14148787855;57525.712371437876;58203.4179658198;7837.7648670539975;7883.881741773993;8145.42981991255;8222.301104405953;8301.252887240178;13236.205827650372;13427;13495.190288582717;13519.121257118255;13552.051356404956;10325.535350909076;10347.223958203316;10635.680929572125;10794.73013174677;10851.635992841928;10173.23700722434;10433.634822781167;10535.57857685684;10537.209709271681;10545.31455455393;11101.5559377624;11156.832647510457;11175.664730058112;11212.719682007688;11484;7860.84278314442;7942.245486678757;8014.559199244098;8028.799280018046;8425.073241943259;11021;11079.113670906469;11155.776884462428;11163.609273675707;11412.942935285271 12:00:31 INFO - PID 21861 | |3;mootools.html;1254.8933340666042;1331.5539294336397;1333;1337.4115389228746;1338.1636477201748;9394.06059394061;9758.804823903518;9759.609615615385;9867.851982220272;10140.23948203884;9754.658586949457;9935.453550054744;9942.154916832078;9950.104490595844;9964.202863770899;2231.1744654477866;2237.865728056314;2260.0959616153505;2262.2534563593977;2272.8068114210314;2141.914323427061;2215.8116560092412;2219.522802597441;2233.7766223377694;2238.0264584905617;2139.4116617930117;2166.2418153646254;2213.612617791888;2228.242397584821;2233.8547994380315;2078.4180429479848;2093.8220251278585;2104.9263275785274;2105.9789402105935;2110.1137522240697;2115.8730476171327;2130.659094544881;2176.1295481807247;2178.455386153462;2198.1756841184556;9847.655332063416;9856.112949834549;9859.161971232454;9879.456629885353;9922.454265015422;5337.2527846101575;5563.13771365439;5563.944360556383;5564.360098588673;5583.218349431083;3314.2377253231894;3380.5943286805496;3420.9486857697157;3465.6187819339852;3485.599156097056;1062.16089289462;1077.7467295185625;1097.358045543358;1105.4969988655143;1119.2333251722596;13382.531611393651;13431.932840335834;13496.325183740872;13499.595012149652;13554.390052447663;4532.88667783308;4738.64460165489;4842;4863.197572400514;4908.558229759339;10198.796024079476;10200.795984080425;10208.081272685495;10228.897711022943;10231.693049208536;5356.250124982505;5455;5457.181422786613;5489.698066606375;5500.7524661390335;4774.331593576902;4945.876353091129;5018.146915024455;5023.6985780853265;5026.497350265017;3694.3350196964802;3734.1971476132217;3754.380527213034;3794.468774371535;3817.8091095445116;1149.5918948773065;1150.7238262817032;1152.2567943676281;1165.6269993602136;1166.2361153444508;683.9008343790123;690.7478770248823;706.6466766616692;710.573655806512;717.0355871353022;5219.086659834514;5239.449857764956;5337.119375303031;6035.185249991283;6035.849103772353;793.6388943030908;813.8819871118773;823.6129019360891;833.3499870101331;841.5623875584662;3455.740819438552;3553.271579326232;3560.0305659189817;3571.714262858965;3701.1117331840164;12357.93821030907;12789.488420463078;12928.159669621633;12937.54718584845;12951.805722914163;12695.809562856564;12728.80906786399;12742.299173545543;12751.043671724658;12771.489140434465;8439.57802109892;8781.868271975925;8812.471251724788;8824.911750882537;8893.066228046091;5749.9712501437225;5899;5914.556408269483;5957.106434034929;5990.341062483036;11006.229563930769;11165.330080195214;11171;11215.943920280346;11306.152038596974;11182.552697891993;11534.653960381202;11550.133739969368;11618.535258589562;11795.056395488513;7760.534367937942;7945.721899733481;7952.165022672768;7960.4825686330205;7961.004874390701;8919.10808919103;9065.77335566616;9145.222656074307;9158.313126515404;9186.356955013085;7176.892346614701;7315.707371705073;7345.1553071397475;7390.9260907390235;7513.248675132443;7091.43268538526;7225.169105552929;7254.746083887038;7302.3792977597495;7316.817079573053;6294.118823364641;6386.137871387304;6453.741850325934;6460.8707825842275;6461.224653041477;5000.949990500048;5087.491250874883;5139.383274007143;5265.183896496049;5275.1032324505695;5167.250748641502;5210.921836172536;5242.68543887368;5281.57747380201;5337.786488540415 12:00:31 INFO - PID 21861 | |4;prototype.html;373.7309137421056;392.2449285126132;395.39899352983474;396.48852979656243;396.63707707447685;5378.596605254602;5535.142052981794;5613.719314034297;5645.407232240612;5696.174054762062;5306.575473962083;5500.202470641754;5509.807156749504;5525.226468294442;5532;4394.846180383687;4407.2948328267485;4409.93385099223;4427.734335939837;4427.77861106945;4300.6989510734265;4389.122175564884;4399.802008909591;4410.49279332876;4451.5993560579545;4349.499807522144;4350.997811510064;4354.564543545652;4357.215701173787;4371.825126994916;4370.8033138508845;4378.540253273424;4380.474343078819;4381.518033016381;4395.890102747425;3834.9616503835164;3949.3483575210057;3961.504811898513;3965.5836137205465;3970.2456533258587;5363.678179309254;5376.354837419495;5392.433794451605;5395.545027012699;5453.427390124019;5088.745562721886;5090.898182036339;5093.567046801027;5101.821436249714;5106.285120083191;5506.119020956668;5761.510271626917;5832.154337621064;5833.270841144857;5853.419576714264;4047.2917239483268;4048.554658987509;4062.7968601569805;4077.531083925357;4078.714489985702;5995.340512543617;6111.755529778803;6138.232720909887;6182.319944806068;6231.6572588507615;4119.237940980868;4134.462519872397;4136.44158038667;4150.543440221573;4175;4240.109576988805;4247.0444150066605;4250.553691862372;4250.808713607895;4254.489461264606;4758.476567577563;4838.2016967200725;4862.51374862518;4862.78117484714;4869.441778630804;5823.30120385548;5824.504917082096;5827.854303642443;5829.5044921181325;5857.20927674767;1439.1868594244218;1450.5358285348586;1450.6083357493628;1454.2292584930003;1455.9226172632175;888.4447220487195;938.3384713776771;953.0279115302353;953.6423841059602;971.7667759737612;5062.835547824021;5078.97460512695;5089.847304580869;5090.694558326512;5100.2349647553165;5970.522358211333;6024.795040991819;6051.394860513913;6053.969730151321;6063.242094738158;4882.853514394574;5029.371328583927;5061.9493805061475;5063.594912406998;5073.061483625467;3184.7452203823636;3203.711665950029;3204.7916885402374;3220.243242837931;3239.076863094007;5595.804146854841;5605.495505404533;5612.747426365823;5626.465485778845;5631.63394379364;5920.763169473173;6144.385561443909;6224.253089629274;6226;6232.594881332699;5607.635503692247;5624.268845050117;5631.324241091177;5637.154426835926;5671.43285671446;5817.563682723728;6056.9091463628965;6076.0278355462915;6093.664848433379;6121.877562448637;5975.25309336333;5980.162777211107;5985.341612422543;5987.982043052604;6016.639001659914;5477.397486276586;5589.413111623221;5596.272484576979;5615.915761263666;5661.207430959751;4054.8986275343354;4070.552239253739;4075.8369665214245;4078.9184216316103;4082.8366865325056;5920.585559010828;6033.129729783605;6098.298695650057;6112.755489780359;6116.755329786936;5865.530757539472;5879.176915231786;5887.116932460165;5896.115582662464;5899.941000590111;5792.4497172768515;5834;5855.853603659943;5860.443257890493;5895.233619629421;5558.833235002957;5719.799807006735;5757.416710404672;5769.480746732815;5812.505936995233;5856.765729370777;5882.617629854046;5893.764249429974;5894.587378883609;5896.941030589639;5452.563794896478;5726.828195154152;5733.967885780599;5740.827775166752;5764.855878603068 12:00:31 INFO - PID 21861 | |5;yui.html;574.8390450673813;599.8350453625255;609.3023488106119;621.3072424246965;641.0416427440977;12811.487540498381;13330.200187988727;13332.333383330832;13350.19898806071;13565.25391103489;14760.852391476083;15093.6981260375;15160.241987900616;15246.923765381158;15265.313060912258;846.8475674378609;884.6903583745702;890.7773056735816;892.8392889279927;893.6693423433338;861.5089399042548;888.7422647432237;889.0353965946923;890.5191196753777;893.7274131389923;948.3219498058886;951.600327862296;954.5275088831004;955.2405837359316;957.5451660461295;945.7304668169538;949.1362859797551;949.4018768176039;949.9382540134869;951.5955718819508;695.7043256615968;695.990813320687;697.132070572141;697.4664381747967;697.5256825358754;12731.554395596202;12853.100282980195;12986.28575428351;12989.545365912241;12993;12449.439775210047;13420.463181472729;13711.588652340446;13737.293401267552;13873.861261387357;8996.685116020908;9115.088491150898;9165.725028249164;9270.953645231799;9643.758906027335;2338.3920180752957;2358.917437889683;2380.321608341614;2383.4279772854566;2385.105585405473;54339.456605433836;57107.42892571063;57446.71276643632;58191.709041454524;58298;9432.717018489318;9712.70861874145;9778;9872.259580531345;10012.148967337713;21314.254001110196;21317.081462668433;21334.14663413446;21347.573048539252;21415.78584214138;5930.080837470199;5982.820515384546;6118.051701986199;6125.693715314216;6134.2332208473945;2831.4903317402654;2836.8297902125937;2909.738123568889;2921.649402071765;2922.503174460347;3661.377565813818;3766.9058273543383;3784.4512545680723;3790.4882840816135;3810.5236845394325;683.6000939450378;686.584616307137;689.407109885498;709.2729951799447;710.8542748736496;413.81774156734616;415.4930984199272;417.53236375259905;422.55842644436024;431.19151590767314;6637.760505125167;7331.74338898136;7457.962710186414;7920.683172673143;7960.681572737026;471.83957454465644;492.45583630088237;499.21623051808314;502.8943921776395;519.6752029981262;3398.9150271243416;3456.498807672873;3506.544149260631;3563.7861728296384;3609.9278014439565;60562.39437605656;60754.69622651947;62359.37640623627;62396;62942.68528657419;50655.74672126689;51546.22680659793;52670.47329526732;53162.202566961525;53630.195547066825;45311;45349.54650453453;45372.77313613411;45773.31340029902;47514.76242618765;8138.918610814053;8284.259707104038;8290.83418331618;8333.250007499355;8361.874571881304;23911.16310929109;23962.760372396053;24259.75740242575;24266.514669706154;25223.24330270095;41537.37693934533;41855.581444186384;43407.782961084995;44151;44866.77566612146;10637.680869573926;10645.627403041166;10731.785364292826;10751.569937202425;11217.943910280397;10938.617148399768;11060.391678457761;11183.832242516206;11192.888071119185;11361.943190283995;10993.450327483433;11362.893561390103;11386.991001602031;11520.82718759236;11880.46537905779;10063.39619622825;10170.542325595514;10171.440570768678;10201.234907381828;10617.362958222531;9889.357191782512;10062.94968525182;10409.42748148859;10426.530806113895;10479.213485945715;8136.599260037461;8289.212524810133;8414.368922330726;8424.452410593536;8469.61886715087;8493.108223636676;8630.654773809229;8631.13688631157;8783.385163038525;8819.426737262058 12:00:31 INFO - PID 21861 | __end_tp_report 12:00:31 INFO - PID 21861 | __start_cc_report 12:00:31 INFO - PID 21861 | _x_x_mozilla_cycle_collect,398 12:00:31 INFO - PID 21861 | __end_cc_report 12:00:31 INFO - PID 21861 | __startTimestamp1490900431620__endTimestamp 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | ------- Summary: start ------- 12:00:31 INFO - PID 21861 | Number of tests: 6 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#0] dojo.html Cycles:165 Average:5168.15 Median:5292.34 stddev:591.37 (11.2%) stddev-sans-first:559.55 12:00:31 INFO - PID 21861 | Values: 2662.1 2674.4 2689.5 2710.7 2718.6 5071.1 5101.8 5110.3 5185.8 5197.1 5181.6 5211.1 5222.3 5294.8 5316.8 4771.5 4797.9 4802.8 4829.7 4840.8 4829.8 4845.6 4900.4 4906.1 4954.9 4672.1 4720.8 4722.5 4827.9 4832.9 4759.4 4778.1 4784.1 4823.0 4840.6 4676.5 4742.2 4751.9 4778.4 4787.1 5021.8 5072.0 5175.1 5183.1 5254.3 5596.2 5653.3 5706.6 5708.5 5714.7 5681.3 5701.5 5705.6 5710.7 5715.4 5140.3 5290.6 5292.3 5292.4 5370.5 5742.1 5751.9 5811.4 5834.2 5856.5 5335.8 5409.6 5469.6 5562.3 5562.6 5595.9 5648.2 5656.2 5657.1 5671.5 5435.9 5627.0 5629.2 5633.6 5635.7 5449.6 5593.6 5672.9 5673.5 5686.7 4756.1 4762.9 4763.8 4766.5 4800.8 4061.4 4073.6 4077.9 4078.1 4105.2 4646.1 4712.0 4774.8 4834.7 4841.2 5667.5 5675.7 5677.1 5698.5 5745.6 4827.1 4841.8 4845.5 4849.9 4868.4 4909.4 4976.2 4990.8 4995.3 5062.2 5163.9 5230.5 5233.5 5236.7 5240.5 5593.9 5602.8 5611.1 5618.5 5620.0 5177.9 5210.9 5305.7 5314.9 5324.5 5566.2 5589.1 5622.8 5624.7 5625.8 5494.6 5680.8 5688.9 5707.8 5711.2 5417.5 5425.9 5478.8 5498.1 5509.0 5495.5 5511.9 5522.5 5525.2 5531.0 5366.8 5405.6 5449.8 5451.4 5503.6 5314.2 5405.8 5422.9 5426.1 5427.3 5228.7 5243.6 5248.4 5256.4 5281.4 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#1] ext.html Cycles:180 Average:33382.41 Median:28995.07 stddev:49830.46 (171.9%) stddev-sans-first:49909.43 12:00:31 INFO - PID 21861 | Values: 595.3 658.7 679.3 1172.0 1175.3 36116.6 36856.3 36906.8 36939.4 36997.0 33044.0 33301.3 33408.2 33439.7 33501.8 6900.6 7290.9 7477.8 7478.0 7478.7 7462.1 7520.7 7521.9 7537.2 7552.3 7539.8 7578.4 7598.9 7622.2 7630.6 7495.0 7522.1 7531.3 7567.6 7587.3 7276.7 7340.2 7383.9 7407.0 7419.7 33697.3 33802.0 33870.3 33876.5 34031.8 2515.6 2520.6 2546.7 2574.7 2610.1 24054.8 24175.5 24424.1 24579.3 24837.3 2603.0 2607.3 2625.9 2627.7 2629.9 161420.0 161757.2 162370.0 162454.0 163468.0 43761.8 43786.3 43796.1 43800.6 43835.6 45119.0 45378.3 45400.8 45441.3 45478.5 12734.1 13009.0 13117.6 13121.3 13123.9 10440.5 10445.1 10445.7 10448.0 10453.5 13164.7 13357.5 13365.5 13425.2 13569.5 5531.2 5569.9 5584.6 5587.9 5605.6 840.9 853.8 857.1 863.1 872.2 20101.9 20713.5 20792.3 20890.4 21181.5 925.7 934.2 947.4 963.0 993.8 10548.5 10629.7 10967.5 11011.0 11017.3 230103.0 230996.0 231503.0 231570.0 231887.0 42922.4 43108.0 43372.0 43414.0 43445.0 1207.4 1238.9 1242.7 1246.3 1247.3 22518.8 23618.0 23647.0 23767.2 23968.0 28956.7 28973.7 28998.3 29013.3 29023.0 174137.0 174700.1 174907.0 175565.0 175998.0 26881.9 28991.9 29311.8 29607.0 29644.0 35000.0 35380.2 35557.6 36019.3 36084.0 26532.0 27445.3 28380.4 28530.6 28630.3 26783.6 26931.6 27401.9 28230.9 28231.0 29637.0 29961.9 30064.4 30751.5 30930.5 26681.9 26830.9 27185.5 27509.2 28223.4 20918.7 22166.8 22336.4 22353.8 22416.4 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#2] jquery.html Cycles:180 Average:27321.57 Median:22069.17 stddev:73503.12 (333.1%) stddev-sans-first:73681.53 12:00:31 INFO - PID 21861 | Values: 404.6 406.0 424.6 429.8 435.0 14896.5 17821.3 18409.0 18680.2 18738.0 16720.8 16843.6 17141.4 17688.4 17944.5 5678.2 5699.3 5709.1 5873.3 5892.9 5727.9 5801.7 5810.3 5810.4 5821.0 5557.7 5712.7 5730.5 5793.5 5815.5 5720.5 5759.5 5771.4 5774.0 5783.7 5005.7 5088.6 5131.1 5136.7 5139.9 21501.9 22131.3 22174.4 22218.3 22483.7 1549.0 1551.8 1565.5 1567.4 1583.2 13852.2 14172.6 14183.6 14832.2 14940.8 1549.1 1596.6 1732.6 1755.8 1766.2 76503.0 78600.0 78949.6 80096.0 80472.0 10937.8 10978.2 10979.0 10989.3 11074.4 14373.6 15552.6 15600.4 15602.4 15636.8 7728.6 7852.6 7975.2 8031.3 8069.2 7229.6 7243.0 7282.0 7453.4 7467.3 6988.4 7035.2 7067.5 7081.1 7264.4 2030.9 2041.1 2053.1 2053.2 2139.1 819.4 835.9 839.2 855.1 869.2 16060.4 16897.6 16917.9 16930.8 17226.1 858.7 859.4 881.0 885.6 885.9 8611.5 9411.0 9475.1 9621.6 9625.4 424741.0 442153.0 446339.0 454317.0 454357.0 87755.0 88943.6 89060.6 89668.6 90333.5 998.0 1020.5 1047.4 1048.4 1048.9 14238.4 14267.4 14293.5 14567.7 15022.6 43084.6 43703.3 43932.8 44402.8 45439.1 53742.5 56124.0 57234.1 57525.7 58203.4 7837.8 7883.9 8145.4 8222.3 8301.3 13236.2 13427.0 13495.2 13519.1 13552.1 10325.5 10347.2 10635.7 10794.7 10851.6 10173.2 10433.6 10535.6 10537.2 10545.3 11101.6 11156.8 11175.7 11212.7 11484.0 7860.8 7942.2 8014.6 8028.8 8425.1 11021.0 11079.1 11155.8 11163.6 11412.9 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#3] mootools.html Cycles:180 Average:6044.10 Median:4885.88 stddev:3779.05 (77.3%) stddev-sans-first:3772.51 12:00:31 INFO - PID 21861 | Values: 1254.9 1331.6 1333.0 1337.4 1338.2 9394.1 9758.8 9759.6 9867.9 10140.2 9754.7 9935.5 9942.2 9950.1 9964.2 2231.2 2237.9 2260.1 2262.3 2272.8 2141.9 2215.8 2219.5 2233.8 2238.0 2139.4 2166.2 2213.6 2228.2 2233.9 2078.4 2093.8 2104.9 2106.0 2110.1 2115.9 2130.7 2176.1 2178.5 2198.2 9847.7 9856.1 9859.2 9879.5 9922.5 5337.3 5563.1 5563.9 5564.4 5583.2 3314.2 3380.6 3420.9 3465.6 3485.6 1062.2 1077.7 1097.4 1105.5 1119.2 13382.5 13431.9 13496.3 13499.6 13554.4 4532.9 4738.6 4842.0 4863.2 4908.6 10198.8 10200.8 10208.1 10228.9 10231.7 5356.3 5455.0 5457.2 5489.7 5500.8 4774.3 4945.9 5018.1 5023.7 5026.5 3694.3 3734.2 3754.4 3794.5 3817.8 1149.6 1150.7 1152.3 1165.6 1166.2 683.9 690.7 706.6 710.6 717.0 5219.1 5239.4 5337.1 6035.2 6035.8 793.6 813.9 823.6 833.3 841.6 3455.7 3553.3 3560.0 3571.7 3701.1 12357.9 12789.5 12928.2 12937.5 12951.8 12695.8 12728.8 12742.3 12751.0 12771.5 8439.6 8781.9 8812.5 8824.9 8893.1 5750.0 5899.0 5914.6 5957.1 5990.3 11006.2 11165.3 11171.0 11215.9 11306.2 11182.6 11534.7 11550.1 11618.5 11795.1 7760.5 7945.7 7952.2 7960.5 7961.0 8919.1 9065.8 9145.2 9158.3 9186.4 7176.9 7315.7 7345.2 7390.9 7513.2 7091.4 7225.2 7254.7 7302.4 7316.8 6294.1 6386.1 6453.7 6460.9 6461.2 5000.9 5087.5 5139.4 5265.2 5275.1 5167.3 5210.9 5242.7 5281.6 5337.8 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#4] prototype.html Cycles:180 Average:4842.48 Median:5507.96 stddev:1415.03 (25.7%) stddev-sans-first:1378.68 12:00:31 INFO - PID 21861 | Values: 373.7 392.2 395.4 396.5 396.6 5378.6 5535.1 5613.7 5645.4 5696.2 5306.6 5500.2 5509.8 5525.2 5532.0 4394.8 4407.3 4409.9 4427.7 4427.8 4300.7 4389.1 4399.8 4410.5 4451.6 4349.5 4351.0 4354.6 4357.2 4371.8 4370.8 4378.5 4380.5 4381.5 4395.9 3835.0 3949.3 3961.5 3965.6 3970.2 5363.7 5376.4 5392.4 5395.5 5453.4 5088.7 5090.9 5093.6 5101.8 5106.3 5506.1 5761.5 5832.2 5833.3 5853.4 4047.3 4048.6 4062.8 4077.5 4078.7 5995.3 6111.8 6138.2 6182.3 6231.7 4119.2 4134.5 4136.4 4150.5 4175.0 4240.1 4247.0 4250.6 4250.8 4254.5 4758.5 4838.2 4862.5 4862.8 4869.4 5823.3 5824.5 5827.9 5829.5 5857.2 1439.2 1450.5 1450.6 1454.2 1455.9 888.4 938.3 953.0 953.6 971.8 5062.8 5079.0 5089.8 5090.7 5100.2 5970.5 6024.8 6051.4 6054.0 6063.2 4882.9 5029.4 5061.9 5063.6 5073.1 3184.7 3203.7 3204.8 3220.2 3239.1 5595.8 5605.5 5612.7 5626.5 5631.6 5920.8 6144.4 6224.3 6226.0 6232.6 5607.6 5624.3 5631.3 5637.2 5671.4 5817.6 6056.9 6076.0 6093.7 6121.9 5975.3 5980.2 5985.3 5988.0 6016.6 5477.4 5589.4 5596.3 5615.9 5661.2 4054.9 4070.6 4075.8 4078.9 4082.8 5920.6 6033.1 6098.3 6112.8 6116.8 5865.5 5879.2 5887.1 5896.1 5899.9 5792.4 5834.0 5855.9 5860.4 5895.2 5558.8 5719.8 5757.4 5769.5 5812.5 5856.8 5882.6 5893.8 5894.6 5896.9 5452.6 5726.8 5734.0 5740.8 5764.9 12:00:31 INFO - PID 21861 | 12:00:31 INFO - PID 21861 | [#5] yui.html Cycles:180 Average:13651.32 Median:24003.61 stddev:16708.33 (69.6%) stddev-sans-first:16726.34 12:00:31 INFO - PID 21861 | Values: 574.8 599.8 609.3 621.3 641.0 12811.5 13330.2 13332.3 13350.2 13565.3 14760.9 15093.7 15160.2 15246.9 15265.3 846.8 884.7 890.8 892.8 893.7 861.5 888.7 889.0 890.5 893.7 948.3 951.6 954.5 955.2 957.5 945.7 949.1 949.4 949.9 951.6 695.7 696.0 697.1 697.5 697.5 12731.6 12853.1 12986.3 12989.5 12993.0 12449.4 13420.5 13711.6 13737.3 13873.9 8996.7 9115.1 9165.7 9271.0 9643.8 2338.4 2358.9 2380.3 2383.4 2385.1 54339.5 57107.4 57446.7 58191.7 58298.0 9432.7 9712.7 9778.0 9872.3 10012.1 21314.3 21317.1 21334.1 21347.6 21415.8 5930.1 5982.8 6118.1 6125.7 6134.2 2831.5 2836.8 2909.7 2921.6 2922.5 3661.4 3766.9 3784.5 3790.5 3810.5 683.6 686.6 689.4 709.3 710.9 413.8 415.5 417.5 422.6 431.2 6637.8 7331.7 7458.0 7920.7 7960.7 471.8 492.5 499.2 502.9 519.7 3398.9 3456.5 3506.5 3563.8 3609.9 60562.4 60754.7 62359.4 62396.0 62942.7 50655.7 51546.2 52670.5 53162.2 53630.2 45311.0 45349.5 45372.8 45773.3 47514.8 8138.9 8284.3 8290.8 8333.3 8361.9 23911.2 23962.8 24259.8 24266.5 25223.2 41537.4 41855.6 43407.8 44151.0 44866.8 10637.7 10645.6 10731.8 10751.6 11217.9 10938.6 11060.4 11183.8 11192.9 11361.9 10993.5 11362.9 11387.0 11520.8 11880.5 10063.4 10170.5 10171.4 10201.2 10617.4 9889.4 10062.9 10409.4 10426.5 10479.2 8136.6 8289.2 8414.4 8424.5 8469.6 8493.1 8630.7 8631.1 8783.4 8819.4 12:00:31 INFO - PID 21861 | -------- Summary: end -------- 12:00:31 INFO - PID 21861 | 12:00:32 INFO - TEST-INFO | 21861: exit 0 12:00:32 INFO - TEST-OK | dromaeo_css | took 1120456ms 12:00:32 INFO - TEST-START | kraken 12:00:32 INFO - operating with platform_type : linux_ 12:00:32 INFO - Initialising browser for kraken test... 12:00:32 INFO - TEST-INFO | started process 22239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX1382F/profile http://localhost:33222/getInfo.html) 12:00:36 INFO - PID 22239 | __metrics Screen width/height:1600/1200 12:00:36 INFO - PID 22239 | colorDepth:24 12:00:36 INFO - PID 22239 | Browser inner width/height: 1024/697 12:00:36 INFO - PID 22239 | __metrics 12:00:37 ERROR - PID 22239 | 1490900437539 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/tmpX1382F/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpX1382F/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpX1382F/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpX1382F/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:00:37 ERROR - PID 22239 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 12:00:38 INFO - TEST-INFO | 22239: exit 0 12:00:38 INFO - Browser initialized. 12:00:38 INFO - Running cycle 1/1 for kraken test... 12:00:38 INFO - TEST-INFO | started process 22372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX1382F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:50 INFO - PID 22372 | RSS: Main: 155377664 12:00:50 INFO - PID 22372 | 12:00:53 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33222/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:54 INFO - PID 22372 | RSS: Main: 161980416 12:00:54 INFO - PID 22372 | 12:00:57 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33222/tests/kraken/driver.html?testName=audio-dft) 12:00:57 INFO - PID 22372 | RSS: Main: 161357824 12:00:57 INFO - PID 22372 | 12:01:00 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33222/tests/kraken/driver.html?testName=audio-fft) 12:01:01 INFO - PID 22372 | RSS: Main: 158216192 12:01:01 INFO - PID 22372 | 12:01:03 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33222/tests/kraken/driver.html?testName=audio-oscillator) 12:01:04 INFO - PID 22372 | RSS: Main: 159035392 12:01:04 INFO - PID 22372 | 12:01:06 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:01:07 INFO - PID 22372 | RSS: Main: 159383552 12:01:07 INFO - PID 22372 | 12:01:10 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33222/tests/kraken/driver.html?testName=imaging-darkroom) 12:01:10 INFO - PID 22372 | RSS: Main: 164212736 12:01:10 INFO - PID 22372 | 12:01:14 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33222/tests/kraken/driver.html?testName=imaging-desaturate) 12:01:15 INFO - PID 22372 | RSS: Main: 161509376 12:01:15 INFO - PID 22372 | 12:01:18 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33222/tests/kraken/driver.html?testName=json-parse-financial) 12:01:18 INFO - PID 22372 | RSS: Main: 162811904 12:01:18 INFO - PID 22372 | 12:01:20 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:01:21 INFO - PID 22372 | RSS: Main: 163422208 12:01:21 INFO - PID 22372 | 12:01:22 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:01:23 INFO - PID 22372 | RSS: Main: 163041280 12:01:23 INFO - PID 22372 | 12:01:25 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:01:26 INFO - PID 22372 | RSS: Main: 163606528 12:01:26 INFO - PID 22372 | 12:01:29 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:01:30 INFO - PID 22372 | RSS: Main: 163942400 12:01:30 INFO - PID 22372 | 12:01:33 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:33 INFO - PID 22372 | RSS: Main: 163737600 12:01:33 INFO - PID 22372 | 12:01:35 INFO - PID 22372 | Cycle 1(1): loaded http://localhost:33222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33222/tests/kraken/driver.html?testName=ai-astar) 12:01:36 INFO - PID 22372 | RSS: Main: 165335040 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | __start_tp_report 12:01:36 INFO - PID 22372 | _x_x_mozilla_page_load 12:01:36 INFO - PID 22372 | _x_x_mozilla_page_load_details 12:01:36 INFO - PID 22372 | |i|pagename|runs| 12:01:36 INFO - PID 22372 | |0;ai-astar;104;112;111;115;114;114;113;113;112;112 12:01:36 INFO - PID 22372 | |1;audio-beat-detection;149;126;125;181;137;130;129;127;155;138 12:01:36 INFO - PID 22372 | |2;audio-dft;166;168;170;171;176;166;165;167;164;171 12:01:36 INFO - PID 22372 | |3;audio-fft;76;76;78;110;77;82;81;76;99;80 12:01:36 INFO - PID 22372 | |4;audio-oscillator;85;84;109;85;84;85;102;85;85;112 12:01:36 INFO - PID 22372 | |5;imaging-gaussian-blur;116;115;115;114;115;119;115;114;114;114 12:01:36 INFO - PID 22372 | |6;imaging-darkroom;152;151;151;152;153;153;152;153;152;153 12:01:36 INFO - PID 22372 | |7;imaging-desaturate;95;96;96;95;95;95;95;94;95;96 12:01:36 INFO - PID 22372 | |8;json-parse-financial;69;69;68;70;70;70;69;68;69;69 12:01:36 INFO - PID 22372 | |9;json-stringify-tinderbox;56;56;56;57;56;55;61;56;59;56 12:01:36 INFO - PID 22372 | |10;stanford-crypto-aes;83;91;84;85;85;84;85;84;85;83 12:01:36 INFO - PID 22372 | |11;stanford-crypto-ccm;143;142;143;135;150;136;140;134;179;137 12:01:36 INFO - PID 22372 | |12;stanford-crypto-pbkdf2;185;203;201;194;196;197;189;212;209;192 12:01:36 INFO - PID 22372 | |13;stanford-crypto-sha256-iterative;74;70;73;73;71;71;72;72;72;74 12:01:36 INFO - PID 22372 | __end_tp_report 12:01:36 INFO - PID 22372 | __start_cc_report 12:01:36 INFO - PID 22372 | _x_x_mozilla_cycle_collect,894 12:01:36 INFO - PID 22372 | __end_cc_report 12:01:36 INFO - PID 22372 | __startTimestamp1490900496056__endTimestamp 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | ------- Summary: start ------- 12:01:36 INFO - PID 22372 | Number of tests: 14 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:1.27 12:01:36 INFO - PID 22372 | Values: 104.0 112.0 111.0 115.0 114.0 114.0 113.0 113.0 112.0 112.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:137.50 stddev:17.67 (12.9%) stddev-sans-first:18.42 12:01:36 INFO - PID 22372 | Values: 149.0 126.0 125.0 181.0 137.0 130.0 129.0 127.0 155.0 138.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#2] audio-dft Cycles:10 Average:168.40 Median:169.00 stddev:3.63 (2.1%) stddev-sans-first:3.74 12:01:36 INFO - PID 22372 | Values: 166.0 168.0 170.0 171.0 176.0 166.0 165.0 167.0 164.0 171.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#3] audio-fft Cycles:10 Average:83.50 Median:79.00 stddev:11.57 (14.6%) stddev-sans-first:11.95 12:01:36 INFO - PID 22372 | Values: 76.0 76.0 78.0 110.0 77.0 82.0 81.0 76.0 99.0 80.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:85.00 stddev:11.35 (13.4%) stddev-sans-first:11.79 12:01:36 INFO - PID 22372 | Values: 85.0 84.0 109.0 85.0 84.0 85.0 102.0 85.0 85.0 112.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 12:01:36 INFO - PID 22372 | Values: 116.0 115.0 115.0 114.0 115.0 119.0 115.0 114.0 114.0 114.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:01:36 INFO - PID 22372 | Values: 152.0 151.0 151.0 152.0 153.0 153.0 152.0 153.0 152.0 153.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:01:36 INFO - PID 22372 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 12:01:36 INFO - PID 22372 | Values: 69.0 69.0 68.0 70.0 70.0 70.0 69.0 68.0 69.0 69.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:1.81 (3.2%) stddev-sans-first:1.90 12:01:36 INFO - PID 22372 | Values: 56.0 56.0 56.0 57.0 56.0 55.0 61.0 56.0 59.0 56.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:2.28 (2.7%) stddev-sans-first:2.32 12:01:36 INFO - PID 22372 | Values: 83.0 91.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 83.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:142.50 stddev:13.24 (9.3%) stddev-sans-first:14.04 12:01:36 INFO - PID 22372 | Values: 143.0 142.0 143.0 135.0 150.0 136.0 140.0 134.0 179.0 137.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:199.00 stddev:8.55 (4.3%) stddev-sans-first:7.71 12:01:36 INFO - PID 22372 | Values: 185.0 203.0 201.0 194.0 196.0 197.0 189.0 212.0 209.0 192.0 12:01:36 INFO - PID 22372 | 12:01:36 INFO - PID 22372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.32 (1.8%) stddev-sans-first:1.22 12:01:36 INFO - PID 22372 | Values: 74.0 70.0 73.0 73.0 71.0 71.0 72.0 72.0 72.0 74.0 12:01:36 INFO - PID 22372 | -------- Summary: end -------- 12:01:36 INFO - PID 22372 | 12:01:37 INFO - TEST-INFO | 22372: exit 0 12:01:37 INFO - TEST-OK | kraken | took 64944ms 12:01:37 INFO - SUITE-END | took 1185s 12:01:37 INFO - Completed test suite (00:19:45) 12:01:37 INFO - javascript benchmark 12:01:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6598.027326469759, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.134806187989, 2674.384891474962, 2689.4755522673076, 2710.715374885637, 2718.6329845470864, 5071.087204303224, 5101.795928162874, 5110.310108135401, 5185.792568297264, 5197.116490196666, 5181.5854731621475, 5211.140161873286, 5222.268882356473, 5294.814681486139, 5316.7873285068645, 4771.475137734847, 4797.90404191916, 4802.783874725646, 4829.710217386951, 4840.806367745286, 4829.782659780319, 4845.612351011928, 4900.431861804224, 4906.092372911005, 4954.900901981958, 4672.065586882637, 4720.787564559569, 4722.456917454502, 4827.9034419311765, 4832.879178020543, 4759.428868535798, 4778.068276686047, 4784.067106914154, 4822.9758851205515, 4840.6127509799135, 4676.5089665584965, 4742.170120228946, 4751.857444276678, 4778.4265888093305, 4787.066522028206, 5021.824236151754, 5072.0, 5175.094358487249, 5183.092958732244, 5254.290670759475, 5596.244506991545, 5653.349864765522, 5706.629069110494, 5708.5433165347085, 5714.685692286923, 5681.261436013292, 5701.515371193412, 5705.5720820938595, 5710.71446427677, 5715.3998830122655, 5140.254663073908, 5290.603204759658, 5292.338457692788, 5292.364916210041, 5370.543503802221, 5742.08126699726, 5751.8562035949435, 5811.4479124483105, 5834.154047663065, 5856.502197313276, 5335.839924802262, 5409.621326507186, 5469.644473109235, 5562.332520097614, 5562.638428502134, 5595.878717690139, 5648.237487939158, 5656.179853921159, 5657.12314591239, 5671.546276297886, 5435.918461223085, 5626.971865140648, 5629.183768353566, 5633.63381380209, 5635.718214089279, 5449.618526703092, 5593.636413633101, 5672.858178545487, 5673.461021203062, 5686.658800471902, 4756.072565849626, 4762.904741905142, 4763.76181190939, 4766.523347665206, 4800.807967681323, 4061.431399604058, 4073.6130067644117, 4077.918441631151, 4078.1435898461064, 4105.158442519277, 4646.140464014168, 4712.010477799632, 4774.809007639656, 4834.685745426536, 4841.176999910023, 5667.489925906688, 5675.659460432387, 5677.120046392815, 5698.487136157766, 5745.626534275259, 4827.131116399011, 4841.830535931296, 4845.4850692601885, 4849.854504364875, 4868.391451068616, 4909.386326709161, 4976.2286845539, 4990.8253211137435, 4995.275685025578, 5062.215356619729, 5163.948360516347, 5230.503102205284, 5233.528982391603, 5236.738163091906, 5240.4759524047295, 5593.916091258553, 5602.775888964396, 5611.074172761612, 5618.4662457066515, 5620.0, 5177.92233116496, 5210.869728256824, 5305.708186049805, 5314.9468505316, 5324.547413469899, 5566.248556444828, 5589.077802162597, 5622.8313150605545, 5624.6625202487985, 5625.803096891589, 5494.587905906993, 5680.801171958961, 5688.943110568841, 5707.828765137053, 5711.171880077449, 5417.485338892799, 5425.945740542544, 5478.753456094406, 5498.120300752021, 5509.0, 5495.450454954473, 5511.944880551143, 5522.502974732293, 5525.171224316385, 5531.032069387921, 5366.785328586813, 5405.621606487508, 5449.809256675997, 5451.400345961862, 5503.587230957774, 5314.229436731575, 5405.837824865261, 5422.891542169214, 5426.104692725656, 5427.294451721251, 5228.738563071755, 5243.58051355883, 5248.448912864094, 5256.421793602777, 5281.445448228034], "value": 5125.528607995494, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.309441048384, 658.739797779877, 679.3071067511139, 1172.0213621625942, 1175.2713317743, 36116.63883361166, 36856.262874742526, 36906.815465922635, 36939.4459083114, 36997.0, 33044.0, 33301.33397332052, 33408.16479588012, 33439.66560334396, 33501.83249083757, 6900.585964842113, 7290.854182916339, 7477.77566672998, 7477.962610186969, 7478.738244161455, 7462.104547454313, 7520.661570229353, 7521.924780752177, 7537.246275372474, 7552.2825331593685, 7539.849203015937, 7578.393728501706, 7598.924010759904, 7622.199669034727, 7630.618469076524, 7494.999999999945, 7522.134954480222, 7531.322181003736, 7567.621618919087, 7587.317141457295, 7276.708931642728, 7340.229275926058, 7383.926160738378, 7406.962965185139, 7419.740309089156, 33697.32605347904, 33802.0, 33870.32259354824, 33876.49185262223, 34031.82984085064, 2515.635232891239, 2520.6345079963485, 2546.719860815309, 2574.7039090504645, 2610.1386542441137, 24054.759452405426, 24175.516489670284, 24424.145154919494, 24579.262622121365, 24837.254882353558, 2602.9869850650816, 2607.2699644099685, 2625.934351641205, 2627.7240889706686, 2629.855357955312, 161420.0, 161757.19121404318, 162370.0, 162454.0, 163468.0, 43761.78119109384, 43786.34320485195, 43796.124077518274, 43800.56199437965, 43835.561644383786, 45119.0, 45378.31932521015, 45400.77299613547, 45441.31838022432, 45478.545214547434, 12734.108612397229, 13009.0, 13117.60647180586, 13121.278329691768, 13123.868761312455, 10440.530176142092, 10445.05994460487, 10445.68662940113, 10448.0, 10453.536504889322, 13164.736705265841, 13357.465701371837, 13365.53220637273, 13425.180712050384, 13569.525066622818, 5531.225628412026, 5569.888602227933, 5584.5811564132855, 5587.888242235133, 5605.607607467519, 840.8864803251482, 853.7694822397917, 857.0957639690187, 863.1239292118505, 872.1627237851733, 20101.899490502456, 20713.482162946046, 20792.27227047046, 20890.373288801362, 21181.470463238544, 925.6760133953197, 934.1825902335456, 947.3984020147257, 962.9614815407446, 993.7813680990171, 10548.525316360781, 10629.73425664349, 10967.50646220922, 11011.0, 11017.338959662446, 230103.0, 230996.0, 231503.0, 231570.0, 231887.0, 42922.356164657554, 43108.0, 43372.0, 43414.0, 43445.0, 1207.4204381896739, 1238.8637249902504, 1242.6644805902356, 1246.3145270101409, 1247.25788156047, 22518.774812252323, 23618.0, 23647.0, 23767.1681491147, 23968.0, 28956.710432896245, 28973.7102628971, 28998.275043123245, 29013.274668133465, 29023.0, 174137.0, 174700.12649937178, 174907.0, 175565.0, 175998.0, 26881.865590672704, 28991.855040724662, 29311.801614879398, 29607.0, 29644.0, 35000.0, 35380.16227322463, 35557.64442355647, 36019.279614408086, 36084.0, 26532.002605759615, 27445.31386715348, 28380.43239135247, 28530.572041418982, 28630.284242894093, 26783.598246026715, 26931.596026060015, 27401.86299068492, 28230.85884570564, 28231.0, 29637.0, 29961.850190749778, 30064.3987120252, 30751.53872691956, 30930.53604195984, 26681.866590666923, 26830.865845670647, 27185.456290874467, 27509.17472475829, 28223.435531288847, 20918.686219707022, 22166.778332216472, 22336.441588960406, 22353.776462235168, 22416.439589010406], "value": 14901.486027506644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.5529689692891, 405.97970101494917, 424.5627004185688, 429.8495526565702, 434.99565004349967, 14896.47862324819, 17821.28714851406, 18409.0, 18680.15939282732, 18737.99999999998, 16720.83279167208, 16843.57891052724, 17141.400050998218, 17688.38090666827, 17944.461666150004, 5678.154599755076, 5699.287589051369, 5709.1150871614755, 5873.324567674708, 5892.941070589303, 5727.942720572803, 5801.7389217485315, 5810.273715785527, 5810.360860305363, 5820.970895145519, 5557.666540007593, 5712.714639206166, 5730.541556675456, 5793.4785869271755, 5815.534757219433, 5720.485156335929, 5759.539236861041, 5771.365149833515, 5774.0, 5783.652980821164, 5005.674631148963, 5088.643794934356, 5131.102057139986, 5136.6661167024395, 5139.922901156486, 21501.892490537448, 22131.336059918227, 22174.445638858997, 22218.333449996528, 22483.66274505884, 1548.95353139406, 1551.8060242469692, 1565.5068653374265, 1567.357383472782, 1583.2163079275833, 13852.168869867739, 14172.574822755334, 14183.57449276513, 14832.184229867353, 14940.775888361683, 1549.1170033081034, 1596.6407558299406, 1732.6274850906989, 1755.8244175582468, 1766.187553725288, 76503.0, 78600.0, 78949.60525197395, 80096.0, 80472.0, 10937.781244375068, 10978.176636752116, 10979.008818780276, 10989.340639561491, 11074.39090850011, 14373.6406589834, 15552.611184720246, 15600.375984960701, 15602.375904963674, 15636.765448518281, 7728.613569321511, 7852.607369631495, 7975.162607926084, 8031.277185053374, 8069.152738962324, 7229.602371869492, 7243.0, 7282.0, 7453.440991925628, 7467.290607392289, 6988.44092472601, 7035.155781306276, 7067.469939754436, 7081.065485185075, 7264.418846492268, 2030.9086091125935, 2041.0917141871726, 2053.1376821734907, 2053.1992522916075, 2139.112268408624, 819.397742659145, 835.9247667709935, 839.202757380491, 855.1363123245567, 869.2437579306044, 16060.43788467398, 16897.577560561083, 16917.915410423117, 16930.830691692925, 17226.138693065295, 858.742377286824, 859.3898332184219, 880.9823803524022, 885.5660726244223, 885.9158379953894, 8611.526366049802, 9411.0, 9475.099865512766, 9621.615135394646, 9625.422474651543, 424741.0, 442153.0, 446339.0, 454317.0, 454357.0, 87755.0, 88943.55528222446, 89060.5546972274, 89668.5516572413, 90333.54833225792, 997.9501024948723, 1020.4897551224387, 1047.402980301221, 1048.3866937841449, 1048.9475526223657, 14238.430462781787, 14267.357968891218, 14293.499727509487, 14567.708645827237, 15022.624434389229, 43084.569154308054, 43703.344449833916, 43932.78033609811, 44402.77798610986, 45439.09121817479, 53742.46257537375, 56124.0, 57234.14148787855, 57525.712371437876, 58203.4179658198, 7837.7648670539975, 7883.881741773993, 8145.42981991255, 8222.301104405953, 8301.252887240178, 13236.205827650372, 13427.0, 13495.190288582717, 13519.121257118255, 13552.051356404956, 10325.535350909076, 10347.223958203316, 10635.680929572125, 10794.73013174677, 10851.635992841928, 10173.23700722434, 10433.634822781167, 10535.57857685684, 10537.209709271681, 10545.31455455393, 11101.5559377624, 11156.832647510457, 11175.664730058112, 11212.719682007688, 11484.0, 7860.84278314442, 7942.245486678757, 8014.559199244098, 8028.799280018046, 8425.073241943259, 11021.0, 11079.113670906469, 11155.776884462428, 11163.609273675707, 11412.942935285271], "value": 8887.010415917695, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.8933340666042, 1331.5539294336397, 1333.0, 1337.4115389228746, 1338.1636477201748, 9394.06059394061, 9758.804823903518, 9759.609615615385, 9867.851982220272, 10140.23948203884, 9754.658586949457, 9935.453550054744, 9942.154916832078, 9950.104490595844, 9964.202863770899, 2231.1744654477866, 2237.865728056314, 2260.0959616153505, 2262.2534563593977, 2272.8068114210314, 2141.914323427061, 2215.8116560092412, 2219.522802597441, 2233.7766223377694, 2238.0264584905617, 2139.4116617930117, 2166.2418153646254, 2213.612617791888, 2228.242397584821, 2233.8547994380315, 2078.4180429479848, 2093.8220251278585, 2104.9263275785274, 2105.9789402105935, 2110.1137522240697, 2115.8730476171327, 2130.659094544881, 2176.1295481807247, 2178.455386153462, 2198.1756841184556, 9847.655332063416, 9856.112949834549, 9859.161971232454, 9879.456629885353, 9922.454265015422, 5337.2527846101575, 5563.13771365439, 5563.944360556383, 5564.360098588673, 5583.218349431083, 3314.2377253231894, 3380.5943286805496, 3420.9486857697157, 3465.6187819339852, 3485.599156097056, 1062.16089289462, 1077.7467295185625, 1097.358045543358, 1105.4969988655143, 1119.2333251722596, 13382.531611393651, 13431.932840335834, 13496.325183740872, 13499.595012149652, 13554.390052447663, 4532.88667783308, 4738.64460165489, 4842.0, 4863.197572400514, 4908.558229759339, 10198.796024079476, 10200.795984080425, 10208.081272685495, 10228.897711022943, 10231.693049208536, 5356.250124982505, 5455.0, 5457.181422786613, 5489.698066606375, 5500.7524661390335, 4774.331593576902, 4945.876353091129, 5018.146915024455, 5023.6985780853265, 5026.497350265017, 3694.3350196964802, 3734.1971476132217, 3754.380527213034, 3794.468774371535, 3817.8091095445116, 1149.5918948773065, 1150.7238262817032, 1152.2567943676281, 1165.6269993602136, 1166.2361153444508, 683.9008343790123, 690.7478770248823, 706.6466766616692, 710.573655806512, 717.0355871353022, 5219.086659834514, 5239.449857764956, 5337.119375303031, 6035.185249991283, 6035.849103772353, 793.6388943030908, 813.8819871118773, 823.6129019360891, 833.3499870101331, 841.5623875584662, 3455.740819438552, 3553.271579326232, 3560.0305659189817, 3571.714262858965, 3701.1117331840164, 12357.93821030907, 12789.488420463078, 12928.159669621633, 12937.54718584845, 12951.805722914163, 12695.809562856564, 12728.80906786399, 12742.299173545543, 12751.043671724658, 12771.489140434465, 8439.57802109892, 8781.868271975925, 8812.471251724788, 8824.911750882537, 8893.066228046091, 5749.9712501437225, 5899.0, 5914.556408269483, 5957.106434034929, 5990.341062483036, 11006.229563930769, 11165.330080195214, 11171.0, 11215.943920280346, 11306.152038596974, 11182.552697891993, 11534.653960381202, 11550.133739969368, 11618.535258589562, 11795.056395488513, 7760.534367937942, 7945.721899733481, 7952.165022672768, 7960.4825686330205, 7961.004874390701, 8919.10808919103, 9065.77335566616, 9145.222656074307, 9158.313126515404, 9186.356955013085, 7176.892346614701, 7315.707371705073, 7345.1553071397475, 7390.9260907390235, 7513.248675132443, 7091.43268538526, 7225.169105552929, 7254.746083887038, 7302.3792977597495, 7316.817079573053, 6294.118823364641, 6386.137871387304, 6453.741850325934, 6460.8707825842275, 6461.224653041477, 5000.949990500048, 5087.491250874883, 5139.383274007143, 5265.183896496049, 5275.1032324505695, 5167.250748641502, 5210.921836172536, 5242.68543887368, 5281.57747380201, 5337.786488540415], "value": 4616.837094377967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7309137421056, 392.2449285126132, 395.39899352983474, 396.48852979656243, 396.63707707447685, 5378.596605254602, 5535.142052981794, 5613.719314034297, 5645.407232240612, 5696.174054762062, 5306.575473962083, 5500.202470641754, 5509.807156749504, 5525.226468294442, 5532.0, 4394.846180383687, 4407.2948328267485, 4409.93385099223, 4427.734335939837, 4427.77861106945, 4300.6989510734265, 4389.122175564884, 4399.802008909591, 4410.49279332876, 4451.5993560579545, 4349.499807522144, 4350.997811510064, 4354.564543545652, 4357.215701173787, 4371.825126994916, 4370.8033138508845, 4378.540253273424, 4380.474343078819, 4381.518033016381, 4395.890102747425, 3834.9616503835164, 3949.3483575210057, 3961.504811898513, 3965.5836137205465, 3970.2456533258587, 5363.678179309254, 5376.354837419495, 5392.433794451605, 5395.545027012699, 5453.427390124019, 5088.745562721886, 5090.898182036339, 5093.567046801027, 5101.821436249714, 5106.285120083191, 5506.119020956668, 5761.510271626917, 5832.154337621064, 5833.270841144857, 5853.419576714264, 4047.2917239483268, 4048.554658987509, 4062.7968601569805, 4077.531083925357, 4078.714489985702, 5995.340512543617, 6111.755529778803, 6138.232720909887, 6182.319944806068, 6231.6572588507615, 4119.237940980868, 4134.462519872397, 4136.44158038667, 4150.543440221573, 4175.0, 4240.109576988805, 4247.0444150066605, 4250.553691862372, 4250.808713607895, 4254.489461264606, 4758.476567577563, 4838.2016967200725, 4862.51374862518, 4862.78117484714, 4869.441778630804, 5823.30120385548, 5824.504917082096, 5827.854303642443, 5829.5044921181325, 5857.20927674767, 1439.1868594244218, 1450.5358285348586, 1450.6083357493628, 1454.2292584930003, 1455.9226172632175, 888.4447220487195, 938.3384713776771, 953.0279115302353, 953.6423841059602, 971.7667759737612, 5062.835547824021, 5078.97460512695, 5089.847304580869, 5090.694558326512, 5100.2349647553165, 5970.522358211333, 6024.795040991819, 6051.394860513913, 6053.969730151321, 6063.242094738158, 4882.853514394574, 5029.371328583927, 5061.9493805061475, 5063.594912406998, 5073.061483625467, 3184.7452203823636, 3203.711665950029, 3204.7916885402374, 3220.243242837931, 3239.076863094007, 5595.804146854841, 5605.495505404533, 5612.747426365823, 5626.465485778845, 5631.63394379364, 5920.763169473173, 6144.385561443909, 6224.253089629274, 6226.0, 6232.594881332699, 5607.635503692247, 5624.268845050117, 5631.324241091177, 5637.154426835926, 5671.43285671446, 5817.563682723728, 6056.9091463628965, 6076.0278355462915, 6093.664848433379, 6121.877562448637, 5975.25309336333, 5980.162777211107, 5985.341612422543, 5987.982043052604, 6016.639001659914, 5477.397486276586, 5589.413111623221, 5596.272484576979, 5615.915761263666, 5661.207430959751, 4054.8986275343354, 4070.552239253739, 4075.8369665214245, 4078.9184216316103, 4082.8366865325056, 5920.585559010828, 6033.129729783605, 6098.298695650057, 6112.755489780359, 6116.755329786936, 5865.530757539472, 5879.176915231786, 5887.116932460165, 5896.115582662464, 5899.941000590111, 5792.4497172768515, 5834.0, 5855.853603659943, 5860.443257890493, 5895.233619629421, 5558.833235002957, 5719.799807006735, 5757.416710404672, 5769.480746732815, 5812.505936995233, 5856.765729370777, 5882.617629854046, 5893.764249429974, 5894.587378883609, 5896.941030589639, 5452.563794896478, 5726.828195154152, 5733.967885780599, 5740.827775166752, 5764.855878603068], "value": 4400.850923503682, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8390450673813, 599.8350453625255, 609.3023488106119, 621.3072424246965, 641.0416427440977, 12811.487540498381, 13330.200187988727, 13332.333383330832, 13350.19898806071, 13565.25391103489, 14760.852391476083, 15093.6981260375, 15160.241987900616, 15246.923765381158, 15265.313060912258, 846.8475674378609, 884.6903583745702, 890.7773056735816, 892.8392889279927, 893.6693423433338, 861.5089399042548, 888.7422647432237, 889.0353965946923, 890.5191196753777, 893.7274131389923, 948.3219498058886, 951.600327862296, 954.5275088831004, 955.2405837359316, 957.5451660461295, 945.7304668169538, 949.1362859797551, 949.4018768176039, 949.9382540134869, 951.5955718819508, 695.7043256615968, 695.990813320687, 697.132070572141, 697.4664381747967, 697.5256825358754, 12731.554395596202, 12853.100282980195, 12986.28575428351, 12989.545365912241, 12993.0, 12449.439775210047, 13420.463181472729, 13711.588652340446, 13737.293401267552, 13873.861261387357, 8996.685116020908, 9115.088491150898, 9165.725028249164, 9270.953645231799, 9643.758906027335, 2338.3920180752957, 2358.917437889683, 2380.321608341614, 2383.4279772854566, 2385.105585405473, 54339.456605433836, 57107.42892571063, 57446.71276643632, 58191.709041454524, 58298.0, 9432.717018489318, 9712.70861874145, 9778.0, 9872.259580531345, 10012.148967337713, 21314.254001110196, 21317.081462668433, 21334.14663413446, 21347.573048539252, 21415.78584214138, 5930.080837470199, 5982.820515384546, 6118.051701986199, 6125.693715314216, 6134.2332208473945, 2831.4903317402654, 2836.8297902125937, 2909.738123568889, 2921.649402071765, 2922.503174460347, 3661.377565813818, 3766.9058273543383, 3784.4512545680723, 3790.4882840816135, 3810.5236845394325, 683.6000939450378, 686.584616307137, 689.407109885498, 709.2729951799447, 710.8542748736496, 413.81774156734616, 415.4930984199272, 417.53236375259905, 422.55842644436024, 431.19151590767314, 6637.760505125167, 7331.74338898136, 7457.962710186414, 7920.683172673143, 7960.681572737026, 471.83957454465644, 492.45583630088237, 499.21623051808314, 502.8943921776395, 519.6752029981262, 3398.9150271243416, 3456.498807672873, 3506.544149260631, 3563.7861728296384, 3609.9278014439565, 60562.39437605656, 60754.69622651947, 62359.37640623627, 62396.0, 62942.68528657419, 50655.74672126689, 51546.22680659793, 52670.47329526732, 53162.202566961525, 53630.195547066825, 45311.0, 45349.54650453453, 45372.77313613411, 45773.31340029902, 47514.76242618765, 8138.918610814053, 8284.259707104038, 8290.83418331618, 8333.250007499355, 8361.874571881304, 23911.16310929109, 23962.760372396053, 24259.75740242575, 24266.514669706154, 25223.24330270095, 41537.37693934533, 41855.581444186384, 43407.782961084995, 44151.0, 44866.77566612146, 10637.680869573926, 10645.627403041166, 10731.785364292826, 10751.569937202425, 11217.943910280397, 10938.617148399768, 11060.391678457761, 11183.832242516206, 11192.888071119185, 11361.943190283995, 10993.450327483433, 11362.893561390103, 11386.991001602031, 11520.82718759236, 11880.46537905779, 10063.39619622825, 10170.542325595514, 10171.440570768678, 10201.234907381828, 10617.362958222531, 9889.357191782512, 10062.94968525182, 10409.42748148859, 10426.530806113895, 10479.213485945715, 8136.599260037461, 8289.212524810133, 8414.368922330726, 8424.452410593536, 8469.61886715087, 8493.108223636676, 8630.654773809229, 8631.13688631157, 8783.385163038525, 8819.426737262058], "value": 5981.999393830697, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 115.0, 114.0, 114.0, 113.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 125.0, 181.0, 137.0, 130.0, 129.0, 127.0, 155.0, 138.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 170.0, 171.0, 176.0, 166.0, 165.0, 167.0, 164.0, 171.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 110.0, 77.0, 82.0, 81.0, 76.0, 99.0, 80.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 85.0, 84.0, 85.0, 102.0, 85.0, 85.0, 112.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 115.0, 119.0, 115.0, 114.0, 114.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 152.0, 153.0, 153.0, 152.0, 153.0, 152.0, 153.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 70.0, 70.0, 69.0, 68.0, 69.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 55.0, 61.0, 56.0, 59.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 143.0, 135.0, 150.0, 136.0, 140.0, 134.0, 179.0, 137.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 203.0, 201.0, 194.0, 196.0, 197.0, 189.0, 212.0, 209.0, 192.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 73.0, 73.0, 71.0, 71.0, 72.0, 72.0, 72.0, 74.0], "value": 72.2, "unit": "score"}]}]} 12:01:37 INFO - Return code: 0 12:01:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:01:37 ERROR - # TBPL SUCCESS # 12:01:37 INFO - Running post-action listener: _resource_record_post_action 12:01:37 INFO - [mozharness: 2017-03-30 19:01:37.867755Z] Finished run-tests step (success) 12:01:37 INFO - Running post-run listener: _resource_record_post_run 12:01:37 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 367132672; Read time: 0; Write time: 269680 12:01:37 INFO - TinderboxPrint: CPU usage
13.3% 12:01:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:01:37 INFO - TinderboxPrint: I/O write bytes / time
367,132,672 / 269,680 12:01:37 INFO - TinderboxPrint: CPU idle
8,304.0 (86.6%) 12:01:37 INFO - TinderboxPrint: CPU user
1,221.4 (12.7%) 12:01:37 INFO - TinderboxPrint: Swap in / out
0 / 0 12:01:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 105799680; Read time: 0; Write time: 95020 12:01:37 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 261332992; Read time: 0; Write time: 174660 12:01:38 INFO - Running post-run listener: _upload_blobber_files 12:01:38 INFO - Blob upload gear active. 12:01:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:01:38 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 12:01:38 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'] 12:01:38 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 12:01:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:01:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:01:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:39 INFO - (blobuploader) - INFO - Done attempting. 12:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:40 INFO - (blobuploader) - INFO - Done attempting. 12:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:41 INFO - (blobuploader) - INFO - Done attempting. 12:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:45 INFO - (blobuploader) - INFO - Done attempting. 12:01:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:45 INFO - Return code: 0 12:01:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d04f0ed47bfa7b1807467a981d1e1e5c858cd80d6ca105c6ca42df218af385d465f4a05d6ac6789c97c9db127c9093bc8649ce2972c92b866a08a339fced23d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c450eef7077f890667b2259dabcd108b8fa3992062487749b7cf90f47ea906550aa0500bc60421547524063371d494d4b7b1129a9c88f240c249929bb841ae37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab326c2946dbd2a3fe18438ac96039ff219ed9d054aa1ff2803c0f6079902f5b3639256c0be7dc8ad5581d4a963efb53d2b94a7586d9b40fbfbf483e1751766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0dfbcd6444262c106c5101c4b58bd078414c8f5be7efc0a7f58574768cea40c35a3d7447902b6a573031a2e1e1984be572a980d050b754486af365e480fca87"} 12:01:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:45 INFO - Contents: 12:01:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d04f0ed47bfa7b1807467a981d1e1e5c858cd80d6ca105c6ca42df218af385d465f4a05d6ac6789c97c9db127c9093bc8649ce2972c92b866a08a339fced23d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c450eef7077f890667b2259dabcd108b8fa3992062487749b7cf90f47ea906550aa0500bc60421547524063371d494d4b7b1129a9c88f240c249929bb841ae37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab326c2946dbd2a3fe18438ac96039ff219ed9d054aa1ff2803c0f6079902f5b3639256c0be7dc8ad5581d4a963efb53d2b94a7586d9b40fbfbf483e1751766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0dfbcd6444262c106c5101c4b58bd078414c8f5be7efc0a7f58574768cea40c35a3d7447902b6a573031a2e1e1984be572a980d050b754486af365e480fca87"} 12:01:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:45 INFO - Copying logs to upload dir... 12:01:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.440885 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-30 12:01:45.072232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:45.076551) ========= 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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d04f0ed47bfa7b1807467a981d1e1e5c858cd80d6ca105c6ca42df218af385d465f4a05d6ac6789c97c9db127c9093bc8649ce2972c92b866a08a339fced23d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c450eef7077f890667b2259dabcd108b8fa3992062487749b7cf90f47ea906550aa0500bc60421547524063371d494d4b7b1129a9c88f240c249929bb841ae37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab326c2946dbd2a3fe18438ac96039ff219ed9d054aa1ff2803c0f6079902f5b3639256c0be7dc8ad5581d4a963efb53d2b94a7586d9b40fbfbf483e1751766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0dfbcd6444262c106c5101c4b58bd078414c8f5be7efc0a7f58574768cea40c35a3d7447902b6a573031a2e1e1984be572a980d050b754486af365e480fca87"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d04f0ed47bfa7b1807467a981d1e1e5c858cd80d6ca105c6ca42df218af385d465f4a05d6ac6789c97c9db127c9093bc8649ce2972c92b866a08a339fced23d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c450eef7077f890667b2259dabcd108b8fa3992062487749b7cf90f47ea906550aa0500bc60421547524063371d494d4b7b1129a9c88f240c249929bb841ae37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ab326c2946dbd2a3fe18438ac96039ff219ed9d054aa1ff2803c0f6079902f5b3639256c0be7dc8ad5581d4a963efb53d2b94a7586d9b40fbfbf483e1751766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0dfbcd6444262c106c5101c4b58bd078414c8f5be7efc0a7f58574768cea40c35a3d7447902b6a573031a2e1e1984be572a980d050b754486af365e480fca87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:45.110334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:45.110717) ========= 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=2432103b8b3de4003b23cad4000001c2-1490898029.99516-729419537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:01:45.324411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 12:01:45.324926) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 12:01:45.327389) ========= ========= Total master_lag: 0.75 =========