builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1490959755.27 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.273151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.273616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.273924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.289190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.289557) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 04:29:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.2K=0.2s 2017-03-31 04:29:16 (58.2 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.275030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.578659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.578985) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020127 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.628843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:15.629210) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 04:29:16,641 truncating revision to first 12 chars 2017-03-31 04:29:16,641 Setting DEBUG logging. 2017-03-31 04:29:16,641 attempt 1/10 2017-03-31 04:29:16,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 04:29:16,941 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:16.312870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:16.313277) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:16.313717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:16.314041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:29:16.324715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-31 04:29:16.325239) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:29:17 INFO - MultiFileLogger online at 20170331 04:29:17 in /builds/slave/test 04:29:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:29:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:17 INFO - {'append_to_log': False, 04:29:17 INFO - 'base_work_dir': '/builds/slave/test', 04:29:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:29:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:17 INFO - 'branch': 'Firefox-Non-PGO', 04:29:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:17 INFO - 'config_files': ('talos/linux_config.py',), 04:29:17 INFO - 'default_actions': ('clobber', 04:29:17 INFO - 'read-buildbot-config', 04:29:17 INFO - 'download-and-extract', 04:29:17 INFO - 'populate-webroot', 04:29:17 INFO - 'create-virtualenv', 04:29:17 INFO - 'install', 04:29:17 INFO - 'run-tests'), 04:29:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:17 INFO - 'download_minidump_stackwalk': True, 04:29:17 INFO - 'download_symbols': 'ondemand', 04:29:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:17 INFO - 'gecko_profile': False, 04:29:17 INFO - 'gecko_profile_interval': 0, 04:29:17 INFO - 'installer_path': 'installer.exe', 04:29:17 INFO - 'log_level': 'info', 04:29:17 INFO - 'log_name': 'talos', 04:29:17 INFO - 'log_to_console': True, 04:29:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:29:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:29:17 INFO - 'opt_config_files': (), 04:29:17 INFO - 'pip_index': False, 04:29:17 INFO - 'suite': 'dromaeojs-e10s', 04:29:17 INFO - 'system_bits': '32', 04:29:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:17 INFO - 'title': 'talos-linux64-ix-069', 04:29:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:17 INFO - 'use_talos_json': True, 04:29:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:17 INFO - 'work_dir': 'build'} 04:29:17 INFO - [mozharness: 2017-03-31 11:29:17.436977Z] Running clobber step. 04:29:17 INFO - Running pre-action listener: _resource_record_pre_action 04:29:17 INFO - Running main action method: clobber 04:29:17 INFO - rmtree: /builds/slave/test/build 04:29:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:18 INFO - Running post-action listener: _resource_record_post_action 04:29:18 INFO - [mozharness: 2017-03-31 11:29:18.370823Z] Finished clobber step (success) 04:29:18 INFO - [mozharness: 2017-03-31 11:29:18.370924Z] Running read-buildbot-config step. 04:29:18 INFO - Running pre-action listener: _resource_record_pre_action 04:29:18 INFO - Running main action method: read_buildbot_config 04:29:18 INFO - Using buildbot properties: 04:29:18 INFO - { 04:29:18 INFO - "project": "", 04:29:18 INFO - "product": "firefox", 04:29:18 INFO - "who": "cbook@mozilla.com", 04:29:18 INFO - "installer_path": "public/build/target.tar.bz2", 04:29:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:29:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:29:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:29:18 INFO - "stage_platform": "linux64", 04:29:18 INFO - "basedir": "/builds/slave/test", 04:29:18 INFO - "buildnumber": 498, 04:29:18 INFO - "platform": "ubuntu64_hw", 04:29:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:29:18 INFO - "slavebuilddir": "test", 04:29:18 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 04:29:18 INFO - "branch": "mozilla-central", 04:29:18 INFO - "script_repo_revision": "production", 04:29:18 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 04:29:18 INFO - "slavename": "talos-linux64-ix-069", 04:29:18 INFO - "repo_path": "mozilla-central" 04:29:18 INFO - } 04:29:18 INFO - Finding installer, test and symbols from parent task. 04:29:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:19 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 04:29:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 04:29:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:19 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 04:29:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 04:29:19 INFO - Running post-action listener: _resource_record_post_action 04:29:19 INFO - [mozharness: 2017-03-31 11:29:19.756799Z] Finished read-buildbot-config step (success) 04:29:19 INFO - [mozharness: 2017-03-31 11:29:19.757019Z] Running download-and-extract step. 04:29:19 INFO - Running pre-action listener: _resource_record_pre_action 04:29:19 INFO - Running main action method: download_and_extract 04:29:19 INFO - mkdir: /builds/slave/test/build/tests 04:29: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')]} 04:29:19 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 04:29:19 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:29:20 INFO - Downloaded 986 bytes. 04:29:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:29:20 INFO - Using the following test package requirements: 04:29:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:29:20 INFO - u'common': [u'target.common.tests.zip'], 04:29:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:29:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:29:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:29:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:29:20 INFO - u'mozbase': [u'target.common.tests.zip'], 04:29:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:29:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:29:20 INFO - u'web-platform': [u'target.common.tests.zip', 04:29:20 INFO - u'target.web-platform.tests.zip'], 04:29:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:29:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:29:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:21 INFO - Expected file size: 58227794 04:29:21 INFO - Obtained file size: 58227794 04:29:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:29:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:31 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:32 INFO - Expected file size: 58227794 04:29:32 INFO - Obtained file size: 58227794 04:29:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 04:29:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:29:42 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 04:29:43 INFO - Expected file size: 14404152 04:29:43 INFO - Obtained file size: 14404152 04:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:43 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:43 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:29:44 INFO - Downloaded 62478421 bytes. 04:29:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:44 INFO - mkdir: /builds/slave/test/properties 04:29:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:44 INFO - Contents: 04:29:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:44 INFO - Running post-action listener: _resource_record_post_action 04:29:44 INFO - Running post-action listener: set_extra_try_arguments 04:29:44 INFO - [mozharness: 2017-03-31 11:29:44.725811Z] Finished download-and-extract step (success) 04:29:44 INFO - [mozharness: 2017-03-31 11:29:44.725909Z] Running populate-webroot step. 04:29:44 INFO - Running pre-action listener: _resource_record_pre_action 04:29:44 INFO - Running main action method: populate_webroot 04:29:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:44 INFO - '--tppagecycles', 04:29:44 INFO - '7'], 04:29:44 INFO - 'tests': ['tsvgm']}}, 04:29:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['damp', 'tps']}, 04:29:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'tests': ['damp', 'tps']}, 04:29:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['dromaeo_dom']}, 04:29:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['basic_compositor_video']}, 04:29:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:29:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['a11yr', 04:29:44 INFO - 'ts_paint', 04:29:44 INFO - 'tpaint', 04:29:44 INFO - 'sessionrestore', 04:29:44 INFO - 'sessionrestore_no_auto_restore', 04:29:44 INFO - 'tabpaint']}, 04:29:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['tsvgx', 04:29:44 INFO - 'tsvgr_opacity', 04:29:44 INFO - 'tart', 04:29:44 INFO - 'tscrollx', 04:29:44 INFO - 'cart', 04:29:44 INFO - 'tsvg_static']}, 04:29:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:44 INFO - 'tsvgr_opacity', 04:29:44 INFO - 'tart', 04:29:44 INFO - 'tscrollx', 04:29:44 INFO - 'cart', 04:29:44 INFO - 'tsvg_static']}, 04:29:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'talos_options': ['--disable-e10s'], 04:29:44 INFO - 'tests': ['tp5o']}, 04:29:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:29:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'talos_options': ['--disable-e10s', 04:29:44 INFO - '--xperf_path', 04:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:44 INFO - 'tests': ['tp5n']}, 04:29:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:29:44 INFO - 'talos_options': ['--xperf_path', 04:29:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:44 INFO - 'tests': ['tp5n']}}, 04:29:44 INFO - 'talos.zip': {'path': '', 04:29:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:44 INFO - Running post-action listener: _resource_record_post_action 04:29:44 INFO - [mozharness: 2017-03-31 11:29:44.739106Z] Finished populate-webroot step (success) 04:29:44 INFO - [mozharness: 2017-03-31 11:29:44.739195Z] Running create-virtualenv step. 04:29:44 INFO - Running pre-action listener: _resource_record_pre_action 04:29:44 INFO - Running main action method: create_virtualenv 04:29:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:29:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:44 INFO - Using real prefix '/usr' 04:29:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:47 INFO - Installing pip.................done. 04:29:47 INFO - Return code: 0 04:29:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:29:47 INFO - Reading from file tmpfile_stdout 04:29:47 INFO - Output received: 04:29:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:29:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:29:47 INFO - Using env: {'DISPLAY': ':0', 04:29:47 INFO - 'HOME': '/home/cltbld', 04:29:47 INFO - 'LANG': 'en_US.UTF-8', 04:29:47 INFO - 'LANGUAGE': 'en_US:en', 04:29:47 INFO - 'LOGNAME': 'cltbld', 04:29:47 INFO - 'MAIL': '/var/mail/cltbld', 04:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:47 INFO - 'MOZ_NO_REMOTE': '1', 04:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:47 INFO - 'NO_EM_RESTART': '1', 04:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:47 INFO - 'PWD': '/builds/slave/test', 04:29:47 INFO - 'SHELL': '/bin/bash', 04:29:47 INFO - 'SHLVL': '1', 04:29:47 INFO - 'TERM': 'linux', 04:29:47 INFO - 'TMOUT': '86400', 04:29:47 INFO - 'USER': 'cltbld', 04:29:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:47 INFO - '_': '/tools/buildbot/bin/python'} 04:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:29:47 INFO - Cleaning up... 04:29:47 INFO - Return code: 0 04:29:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:29:47 INFO - Using env: {'DISPLAY': ':0', 04:29:47 INFO - 'HOME': '/home/cltbld', 04:29:47 INFO - 'LANG': 'en_US.UTF-8', 04:29:47 INFO - 'LANGUAGE': 'en_US:en', 04:29:47 INFO - 'LOGNAME': 'cltbld', 04:29:47 INFO - 'MAIL': '/var/mail/cltbld', 04:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:47 INFO - 'MOZ_NO_REMOTE': '1', 04:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:47 INFO - 'NO_EM_RESTART': '1', 04:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:47 INFO - 'PWD': '/builds/slave/test', 04:29:47 INFO - 'SHELL': '/bin/bash', 04:29:47 INFO - 'SHLVL': '1', 04:29:47 INFO - 'TERM': 'linux', 04:29:47 INFO - 'TMOUT': '86400', 04:29:47 INFO - 'USER': 'cltbld', 04:29:47 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:47 INFO - '_': '/tools/buildbot/bin/python'} 04:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:47 INFO - Downloading/unpacking psutil>=3.1.1 04:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:50 INFO - Installing collected packages: psutil 04:29:50 INFO - Running setup.py install for psutil 04:29:50 INFO - building 'psutil._psutil_linux' extension 04:29:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:29:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:29:50 INFO - building 'psutil._psutil_posix' extension 04:29:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:29:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:29:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:50 INFO - Successfully installed psutil 04:29:50 INFO - Cleaning up... 04:29:50 INFO - Return code: 0 04:29:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:50 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:29:50 INFO - Using env: {'DISPLAY': ':0', 04:29:50 INFO - 'HOME': '/home/cltbld', 04:29:50 INFO - 'LANG': 'en_US.UTF-8', 04:29:50 INFO - 'LANGUAGE': 'en_US:en', 04:29:50 INFO - 'LOGNAME': 'cltbld', 04:29:50 INFO - 'MAIL': '/var/mail/cltbld', 04:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:50 INFO - 'MOZ_NO_REMOTE': '1', 04:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:50 INFO - 'NO_EM_RESTART': '1', 04:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:50 INFO - 'PWD': '/builds/slave/test', 04:29:50 INFO - 'SHELL': '/bin/bash', 04:29:50 INFO - 'SHLVL': '1', 04:29:50 INFO - 'TERM': 'linux', 04:29:50 INFO - 'TMOUT': '86400', 04:29:50 INFO - 'USER': 'cltbld', 04:29:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:50 INFO - '_': '/tools/buildbot/bin/python'} 04:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:29:52 INFO - Installing collected packages: mozsystemmonitor 04:29:52 INFO - Running setup.py install for mozsystemmonitor 04:29:53 INFO - Successfully installed mozsystemmonitor 04:29:53 INFO - Cleaning up... 04:29:53 INFO - Return code: 0 04:29:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:29:53 INFO - Using env: {'DISPLAY': ':0', 04:29:53 INFO - 'HOME': '/home/cltbld', 04:29:53 INFO - 'LANG': 'en_US.UTF-8', 04:29:53 INFO - 'LANGUAGE': 'en_US:en', 04:29:53 INFO - 'LOGNAME': 'cltbld', 04:29:53 INFO - 'MAIL': '/var/mail/cltbld', 04:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:53 INFO - 'MOZ_NO_REMOTE': '1', 04:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:53 INFO - 'NO_EM_RESTART': '1', 04:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:53 INFO - 'PWD': '/builds/slave/test', 04:29:53 INFO - 'SHELL': '/bin/bash', 04:29:53 INFO - 'SHLVL': '1', 04:29:53 INFO - 'TERM': 'linux', 04:29:53 INFO - 'TMOUT': '86400', 04:29:53 INFO - 'USER': 'cltbld', 04:29:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:53 INFO - '_': '/tools/buildbot/bin/python'} 04:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:55 INFO - warning: no files found matching '*.txt' 04:29:55 INFO - no previously-included directories found matching 'build' 04:29:55 INFO - no previously-included directories found matching 'dist' 04:29:55 INFO - no previously-included directories found matching '.git*' 04:29:55 INFO - Installing collected packages: jsonschema, functools32 04:29:55 INFO - Running setup.py install for functools32 04:29:55 INFO - warning: no files found matching '*.txt' 04:29:55 INFO - no previously-included directories found matching 'build' 04:29:55 INFO - no previously-included directories found matching 'dist' 04:29:55 INFO - no previously-included directories found matching '.git*' 04:29:55 INFO - Successfully installed jsonschema functools32 04:29:55 INFO - Cleaning up... 04:29:55 INFO - Return code: 0 04:29:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:29:55 INFO - Using env: {'DISPLAY': ':0', 04:29:55 INFO - 'HOME': '/home/cltbld', 04:29:55 INFO - 'LANG': 'en_US.UTF-8', 04:29:55 INFO - 'LANGUAGE': 'en_US:en', 04:29:55 INFO - 'LOGNAME': 'cltbld', 04:29:55 INFO - 'MAIL': '/var/mail/cltbld', 04:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:55 INFO - 'MOZ_NO_REMOTE': '1', 04:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:55 INFO - 'NO_EM_RESTART': '1', 04:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:55 INFO - 'PWD': '/builds/slave/test', 04:29:55 INFO - 'SHELL': '/bin/bash', 04:29:55 INFO - 'SHLVL': '1', 04:29:55 INFO - 'TERM': 'linux', 04:29:55 INFO - 'TMOUT': '86400', 04:29:55 INFO - 'USER': 'cltbld', 04:29:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:55 INFO - '_': '/tools/buildbot/bin/python'} 04:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:29:56 INFO - Cleaning up... 04:29:56 INFO - Return code: 0 04:29:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:56 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:29:56 INFO - Using env: {'DISPLAY': ':0', 04:29:56 INFO - 'HOME': '/home/cltbld', 04:29:56 INFO - 'LANG': 'en_US.UTF-8', 04:29:56 INFO - 'LANGUAGE': 'en_US:en', 04:29:56 INFO - 'LOGNAME': 'cltbld', 04:29:56 INFO - 'MAIL': '/var/mail/cltbld', 04:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:56 INFO - 'MOZ_NO_REMOTE': '1', 04:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:56 INFO - 'NO_EM_RESTART': '1', 04:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:56 INFO - 'PWD': '/builds/slave/test', 04:29:56 INFO - 'SHELL': '/bin/bash', 04:29:56 INFO - 'SHLVL': '1', 04:29:56 INFO - 'TERM': 'linux', 04:29:56 INFO - 'TMOUT': '86400', 04:29:56 INFO - 'USER': 'cltbld', 04:29:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:56 INFO - '_': '/tools/buildbot/bin/python'} 04:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:59 INFO - Downloading docopt-0.6.1.tar.gz 04:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:59 INFO - Running setup.py install for blobuploader 04:29:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:59 INFO - Running setup.py install for requests 04:29:59 INFO - Running setup.py install for docopt 04:29:59 INFO - Successfully installed blobuploader requests docopt 04:29:59 INFO - Cleaning up... 04:29:59 INFO - Return code: 0 04:29:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:59 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:59 INFO - Using env: {'DISPLAY': ':0', 04:29:59 INFO - 'HOME': '/home/cltbld', 04:29:59 INFO - 'LANG': 'en_US.UTF-8', 04:29:59 INFO - 'LANGUAGE': 'en_US:en', 04:29:59 INFO - 'LOGNAME': 'cltbld', 04:29:59 INFO - 'MAIL': '/var/mail/cltbld', 04:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:59 INFO - 'MOZ_NO_REMOTE': '1', 04:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:59 INFO - 'NO_EM_RESTART': '1', 04:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:59 INFO - 'PWD': '/builds/slave/test', 04:29:59 INFO - 'SHELL': '/bin/bash', 04:29:59 INFO - 'SHLVL': '1', 04:29:59 INFO - 'TERM': 'linux', 04:29:59 INFO - 'TMOUT': '86400', 04:29:59 INFO - 'USER': 'cltbld', 04:29:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:59 INFO - '_': '/tools/buildbot/bin/python'} 04:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:59 INFO - Running setup.py (path:/tmp/pip-rjw1CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:00 INFO - Running setup.py (path:/tmp/pip-R6XgXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:00 INFO - Running setup.py (path:/tmp/pip-vPC1Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:00 INFO - Running setup.py (path:/tmp/pip-uLl5AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:00 INFO - Running setup.py (path:/tmp/pip-mZHgdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:00 INFO - Running setup.py (path:/tmp/pip-RjXxZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:00 INFO - Running setup.py (path:/tmp/pip-iE7u8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:00 INFO - Running setup.py (path:/tmp/pip-aYGjht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:00 INFO - Running setup.py (path:/tmp/pip-1jmumm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:00 INFO - Running setup.py (path:/tmp/pip-pBpBfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:00 INFO - Running setup.py (path:/tmp/pip-lJcHip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:00 INFO - Running setup.py (path:/tmp/pip-j_O5IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:00 INFO - Running setup.py (path:/tmp/pip-tPNrNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:00 INFO - Running setup.py (path:/tmp/pip-zIo_RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:00 INFO - Running setup.py (path:/tmp/pip-wZRdCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:01 INFO - Running setup.py (path:/tmp/pip-z218qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:01 INFO - Running setup.py (path:/tmp/pip-2drIva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:01 INFO - Running setup.py install for manifestparser 04:30:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Running setup.py install for mozcrash 04:30:01 INFO - Running setup.py install for mozdebug 04:30:01 INFO - Running setup.py install for mozdevice 04:30:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Running setup.py install for mozfile 04:30:01 INFO - Running setup.py install for mozhttpd 04:30:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Running setup.py install for mozinfo 04:30:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Running setup.py install for mozInstall 04:30:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:01 INFO - Running setup.py install for mozleak 04:30:02 INFO - Running setup.py install for mozlog 04:30:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Running setup.py install for moznetwork 04:30:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Running setup.py install for mozprocess 04:30:02 INFO - Running setup.py install for mozprofile 04:30:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Running setup.py install for mozrunner 04:30:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Running setup.py install for mozscreenshot 04:30:02 INFO - Running setup.py install for moztest 04:30:02 INFO - Running setup.py install for mozversion 04:30:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:02 INFO - Cleaning up... 04:30:02 INFO - Return code: 0 04:30:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:02 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:02 INFO - Using env: {'DISPLAY': ':0', 04:30:02 INFO - 'HOME': '/home/cltbld', 04:30:02 INFO - 'LANG': 'en_US.UTF-8', 04:30:02 INFO - 'LANGUAGE': 'en_US:en', 04:30:02 INFO - 'LOGNAME': 'cltbld', 04:30:02 INFO - 'MAIL': '/var/mail/cltbld', 04:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:02 INFO - 'MOZ_NO_REMOTE': '1', 04:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:02 INFO - 'NO_EM_RESTART': '1', 04:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:02 INFO - 'PWD': '/builds/slave/test', 04:30:02 INFO - 'SHELL': '/bin/bash', 04:30:02 INFO - 'SHLVL': '1', 04:30:02 INFO - 'TERM': 'linux', 04:30:02 INFO - 'TMOUT': '86400', 04:30:02 INFO - 'USER': 'cltbld', 04:30:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:02 INFO - '_': '/tools/buildbot/bin/python'} 04:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:03 INFO - Running setup.py (path:/tmp/pip-cO5FTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:03 INFO - Running setup.py (path:/tmp/pip-E4hL5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:03 INFO - Running setup.py (path:/tmp/pip-qubZ0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:03 INFO - Running setup.py (path:/tmp/pip-BrQEL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:03 INFO - Running setup.py (path:/tmp/pip-qxlF_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:03 INFO - Running setup.py (path:/tmp/pip-2J1WlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:03 INFO - Running setup.py (path:/tmp/pip-yMvaRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:03 INFO - Running setup.py (path:/tmp/pip-fVP6lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:03 INFO - Running setup.py (path:/tmp/pip-dz_yzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:03 INFO - Running setup.py (path:/tmp/pip-1bvfs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:03 INFO - Running setup.py (path:/tmp/pip-vg1SVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:03 INFO - Running setup.py (path:/tmp/pip-L7chYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:04 INFO - Running setup.py (path:/tmp/pip-o7SaE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:04 INFO - Running setup.py (path:/tmp/pip-GAm35g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:04 INFO - Running setup.py (path:/tmp/pip-qSmUYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:04 INFO - Running setup.py (path:/tmp/pip-iI70Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:04 INFO - Running setup.py (path:/tmp/pip-L5CZne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:06 INFO - Downloading blessings-1.6.tar.gz 04:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:06 INFO - Installing collected packages: blessings 04:30:06 INFO - Running setup.py install for blessings 04:30:06 INFO - Successfully installed blessings 04:30:06 INFO - Cleaning up... 04:30:06 INFO - Return code: 0 04:30:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:06 INFO - Reading from file tmpfile_stdout 04:30:06 INFO - Current package versions: 04:30:06 INFO - argparse == 1.2.1 04:30:06 INFO - blessings == 1.6 04:30:06 INFO - blobuploader == 1.2.4 04:30:06 INFO - docopt == 0.6.1 04:30:06 INFO - functools32 == 3.2.3-2 04:30:06 INFO - jsonschema == 2.5.1 04:30:06 INFO - manifestparser == 1.1 04:30:06 INFO - mozInstall == 1.12 04:30:06 INFO - mozcrash == 1.0 04:30:06 INFO - mozdebug == 0.1 04:30:06 INFO - mozdevice == 0.49 04:30:06 INFO - mozfile == 1.2 04:30:06 INFO - mozhttpd == 0.7 04:30:06 INFO - mozinfo == 0.9 04:30:06 INFO - mozleak == 0.1 04:30:06 INFO - mozlog == 3.4 04:30:06 INFO - moznetwork == 0.27 04:30:06 INFO - mozprocess == 0.25 04:30:06 INFO - mozprofile == 0.28 04:30:06 INFO - mozrunner == 6.13 04:30:06 INFO - mozscreenshot == 0.1 04:30:06 INFO - mozsystemmonitor == 0.3 04:30:06 INFO - moztest == 0.8 04:30:06 INFO - mozversion == 1.4 04:30:06 INFO - psutil == 3.1.1 04:30:06 INFO - requests == 1.2.3 04:30:06 INFO - wsgiref == 0.1.2 04:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:06 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:30:06 INFO - Using env: {'DISPLAY': ':0', 04:30:06 INFO - 'HOME': '/home/cltbld', 04:30:06 INFO - 'LANG': 'en_US.UTF-8', 04:30:06 INFO - 'LANGUAGE': 'en_US:en', 04:30:06 INFO - 'LOGNAME': 'cltbld', 04:30:06 INFO - 'MAIL': '/var/mail/cltbld', 04:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:06 INFO - 'MOZ_NO_REMOTE': '1', 04:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:06 INFO - 'NO_EM_RESTART': '1', 04:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:06 INFO - 'PWD': '/builds/slave/test', 04:30:06 INFO - 'SHELL': '/bin/bash', 04:30:06 INFO - 'SHLVL': '1', 04:30:06 INFO - 'TERM': 'linux', 04:30:06 INFO - 'TMOUT': '86400', 04:30:06 INFO - 'USER': 'cltbld', 04:30:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:06 INFO - '_': '/tools/buildbot/bin/python'} 04:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:30:07 INFO - Cleaning up... 04:30:07 INFO - Return code: 0 04:30:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:07 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2375b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:30:07 INFO - Using env: {'DISPLAY': ':0', 04:30:07 INFO - 'HOME': '/home/cltbld', 04:30:07 INFO - 'LANG': 'en_US.UTF-8', 04:30:07 INFO - 'LANGUAGE': 'en_US:en', 04:30:07 INFO - 'LOGNAME': 'cltbld', 04:30:07 INFO - 'MAIL': '/var/mail/cltbld', 04:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:07 INFO - 'MOZ_NO_REMOTE': '1', 04:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:07 INFO - 'NO_EM_RESTART': '1', 04:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:07 INFO - 'PWD': '/builds/slave/test', 04:30:07 INFO - 'SHELL': '/bin/bash', 04:30:07 INFO - 'SHLVL': '1', 04:30:07 INFO - 'TERM': 'linux', 04:30:07 INFO - 'TMOUT': '86400', 04:30:07 INFO - 'USER': 'cltbld', 04:30:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:07 INFO - '_': '/tools/buildbot/bin/python'} 04:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:30:07 INFO - Cleaning up... 04:30:07 INFO - Return code: 0 04:30:07 INFO - Running post-action listener: _resource_record_post_action 04:30:07 INFO - Running post-action listener: _start_resource_monitoring 04:30:07 INFO - Starting resource monitoring. 04:30:07 INFO - [mozharness: 2017-03-31 11:30:07.398852Z] Finished create-virtualenv step (success) 04:30:07 INFO - [mozharness: 2017-03-31 11:30:07.399323Z] Running install step. 04:30:07 INFO - Running pre-action listener: _resource_record_pre_action 04:30:07 INFO - Running main action method: install 04:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:07 INFO - Reading from file tmpfile_stdout 04:30:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:07 INFO - Reading from file tmpfile_stdout 04:30:07 INFO - Output received: 04:30:07 INFO - Usage: mozinstall [options] installer 04:30:07 INFO - Options: 04:30:07 INFO - -h, --help show this help message and exit 04:30:07 INFO - -d DEST, --destination=DEST 04:30:07 INFO - Directory to install application into. [default: 04:30:07 INFO - "/builds/slave/test"] 04:30:07 INFO - --app=APP Application being installed. [default: firefox] 04:30:07 INFO - mkdir: /builds/slave/test/build/application 04:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:30:23 INFO - Reading from file tmpfile_stdout 04:30:23 INFO - Output received: 04:30:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:23 INFO - Running post-action listener: _resource_record_post_action 04:30:23 INFO - [mozharness: 2017-03-31 11:30:23.435450Z] Finished install step (success) 04:30:23 INFO - [mozharness: 2017-03-31 11:30:23.435725Z] Running run-tests step. 04:30:23 INFO - Running pre-action listener: _resource_record_pre_action 04:30:23 INFO - Running main action method: run_tests 04:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:23 INFO - Python 2.7.3 04:30:23 INFO - Return code: 0 04:30:23 INFO - grabbing minidump binary from tooltool 04:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:23 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 0x2373290>, '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 0x2373b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2374040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:30:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:30:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:30:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:23 INFO - Return code: 0 04:30:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:23 INFO - ENV: RUST_BACKTRACE is now 1 04:30:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:23 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-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:30:23 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-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:30:23 INFO - Using env: {'DISPLAY': ':0', 04:30:23 INFO - 'HOME': '/home/cltbld', 04:30:23 INFO - 'LANG': 'en_US.UTF-8', 04:30:23 INFO - 'LANGUAGE': 'en_US:en', 04:30:23 INFO - 'LOGNAME': 'cltbld', 04:30:23 INFO - 'MAIL': '/var/mail/cltbld', 04:30:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:23 INFO - 'MOZ_NO_REMOTE': '1', 04:30:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:23 INFO - 'NO_EM_RESTART': '1', 04:30:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:23 INFO - 'PWD': '/builds/slave/test', 04:30:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:23 INFO - 'RUST_BACKTRACE': '1', 04:30:23 INFO - 'SHELL': '/bin/bash', 04:30:23 INFO - 'SHLVL': '1', 04:30:23 INFO - 'TERM': 'linux', 04:30:23 INFO - 'TMOUT': '86400', 04:30:23 INFO - 'USER': 'cltbld', 04:30:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454', 04:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:23 INFO - '_': '/tools/buildbot/bin/python'} 04:30:23 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-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:30:23 INFO - mozversion application_buildid: 20170330114804 04:30:23 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:23 INFO - mozversion application_display_name: Nightly 04:30:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:23 INFO - mozversion application_name: Firefox 04:30:23 INFO - mozversion application_remotingname: firefox 04:30:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:23 INFO - mozversion application_vendor: Mozilla 04:30:23 INFO - mozversion application_version: 55.0a1 04:30:23 INFO - mozversion platform_buildid: 20170330114804 04:30:23 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:23 INFO - mozversion platform_version: 55.0a1 04:30:23 INFO - using testdate: 1490959823 04:30:23 INFO - actual date: 1490959823 04:30:23 INFO - starting webserver on 'localhost:58850' 04:30:23 INFO - SUITE-START | Running 2 tests 04:30:23 INFO - TEST-START | dromaeo_css 04:30:23 INFO - operating with platform_type : linux_ 04:30:23 INFO - Initialising browser for dromaeo_css test... 04:30:23 INFO - TEST-INFO | started process 16504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_58cS/profile http://localhost:58850/getInfo.html) 04:30:28 INFO - PID 16504 | __metrics Screen width/height:1600/1200 04:30:28 INFO - PID 16504 | colorDepth:24 04:30:28 INFO - PID 16504 | Browser inner width/height: 1024/697 04:30:28 INFO - PID 16504 | __metrics 04:30:29 ERROR - PID 16504 | 1490959829050 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/tmp2_58cS/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp2_58cS/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp2_58cS/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp2_58cS/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:30:29 ERROR - PID 16504 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:30:29 INFO - TEST-INFO | 16504: exit 0 04:30:29 INFO - Browser initialized. 04:30:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:30 INFO - TEST-INFO | started process 16634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_58cS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:42 INFO - PID 16634 | RSS: Main: 155877376 04:30:42 INFO - PID 16634 | 04:33:47 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58850/tests/dromaeo/cssquery-ext.html) 04:33:49 INFO - PID 16634 | RSS: Main: 166981632 04:33:49 INFO - PID 16634 | 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | A coding exception was thrown and uncaught in a Task. 04:35:30 INFO - PID 16634 | 04:35:30 ERROR - PID 16634 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:30 INFO - PID 16634 | Full stack: 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | A coding exception was thrown and uncaught in a Task. 04:35:30 INFO - PID 16634 | 04:35:30 ERROR - PID 16634 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:30 INFO - PID 16634 | Full stack: 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | A coding exception was thrown and uncaught in a Task. 04:35:30 INFO - PID 16634 | 04:35:30 ERROR - PID 16634 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:30 INFO - PID 16634 | Full stack: 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | ************************* 04:35:30 INFO - PID 16634 | A coding exception was thrown and uncaught in a Task. 04:35:30 INFO - PID 16634 | 04:35:30 ERROR - PID 16634 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:30 INFO - PID 16634 | Full stack: 04:35:30 INFO - PID 16634 | ************************* 04:36:51 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-ext.html (next: http://localhost:58850/tests/dromaeo/cssquery-jquery.html) 04:36:52 INFO - PID 16634 | RSS: Main: 161120256 04:36:52 INFO - PID 16634 | 04:39:54 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58850/tests/dromaeo/cssquery-mootools.html) 04:39:54 INFO - PID 16634 | RSS: Main: 168759296 04:39:54 INFO - PID 16634 | 04:42:56 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58850/tests/dromaeo/cssquery-prototype.html) 04:42:57 INFO - PID 16634 | RSS: Main: 160276480 04:42:57 INFO - PID 16634 | 04:46:00 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58850/tests/dromaeo/cssquery-yui.html) 04:46:00 INFO - PID 16634 | RSS: Main: 170180608 04:46:00 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | Cycle 1(1): loaded http://localhost:58850/tests/dromaeo/cssquery-yui.html (next: http://localhost:58850/tests/dromaeo/cssquery-dojo.html) 04:49:03 INFO - PID 16634 | RSS: Main: 162136064 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | __start_tp_report 04:49:03 INFO - PID 16634 | _x_x_mozilla_page_load 04:49:03 INFO - PID 16634 | _x_x_mozilla_page_load_details 04:49:03 INFO - PID 16634 | |i|pagename|runs| 04:49:03 INFO - PID 16634 | |0;dojo.html;2689.327668082979;2718.4291298827247;2726.781857451404;2737.958930616041;2748.4365705030473;5109.182530795074;5196.558292545138;5258.921116183255;5262.421133675302;5314.229436731672;5180.430152683211;5215.322008138936;5215.58275337973;5306.893862122755;5341.252224688546;4796.784144713479;4820.903581928359;4834.371531700874;4846.0550192712435;4866.926996095061;4839.516048395168;4877.634177436688;4890.828820991266;4898.02039592083;4923.70457772533;4651.302304654295;4700.29495575663;4741.170295198361;4811.494793046715;4823.638227132979;4722;4747.6914000590195;4748.3589715388325;4792.520747925215;4794;4639.188142075157;4708.929366059512;4715.905681886343;4740.360051393052;4746.786394612216;5060.139776238048;5127.897442051175;5163.225516172567;5165.896682066375;5182.2485739567555;5649.604527683064;5658.236138121342;5686.601937864351;5711.7715291388295;5714.771409143629;5686.971565142189;5691.743871525791;5701.059325211335;5704.429557044304;5711.485966263015;5170.1986192140275;5273.6572122811895;5281.709505977208;5282.075636763551;5351.357837059578;5760.654360738369;5819.94180058194;5873.941260587425;5887.381824908323;5891.027980383275;5404.3784964728775;5470.17947307907;5539.861503462445;5556.888862222733;5589.776408943678;5628.240187574707;5659.5755318351285;5661.433856614306;5665.915011274834;5675.489205971482;5462.5083742462575;5625.8593535161945;5629.549636029108;5631.070873305941;5640.266765320482;5488.423715509894;5493.093639549509;5493.2034854945805;5494;5497.917531237034;4686.882827929261;4688.578027977498;4689.882752931136;4694.201985662446;4697.577218050324;4060.309747342959;4079.4900637420324;4086.8773936781945;4088.34586466164;4089.1003979124544;4756.453007904066;4764.785584648699;4766.308885211625;4766.976165119152;4775.331453596499;5518.889622207614;5569.944300557024;5572;5572.637778544382;5581.944180558143;4721.787519561628;4749.525047495292;4765.142274390643;4776.379070720854;4779.904401912012;5004.949950500449;5046.596272298208;5062.974685126551;5067.847964561069;5068;5294.894102117859;5295.4969277918535;5295.920561191509;5302.390225124083;5341.198820177005;5539.750711218086;5602.691851948019;5651.095824668033;5680.77276908919;5685.147227915681;5268.9736551317;5270.23581580661;5273.947260527346;5285.814996475105;5312.123499622519;5555.416681248411;5561.499465048003;5566.137248726453;5572.777088916398;5624.971875140598;5499.120140777456;5554.583406244467;5647.407022262768;5651.689157096234;5670.716464176857;5474.315710536183;5479.726013699219;5481.287432633732;5508.889822203613;5534.08687566547;5441.238226648194;5455.645383050089;5460.972695136499;5464.480874316933;5467.234587157881;5265.921011184759;5330.946690533045;5368.772488409586;5404.189371594292;5463.31708536433;5508.421615730451;5534.280543529316;5567.5545956322585;5575.944240557705;5585.776568937197;5274.314339135888;5375.381831089475;5376.838694839161;5425.593080518898;5436.918446223231 04:49:03 INFO - PID 16634 | |1;ext.html;595.359988012886;662.652107643487;686.0703746423596;1203.8916497515222;1216.659335386091;34948.3010339793;36318.09204769882;36342.091447713785;36406.817965910166;36410.635893641054;33866.661333386655;34139.31721365571;34276.31447371051;34344.656553434455;34383.828080859625;7335.119785625706;7526.247375262457;7527.548347099164;7527.5859827709455;7529.698812047539;7463.3283004529585;7505.849883002364;7527.962360188191;7546.69813207471;7559.244075592424;7522.774316770478;7552.2825331593685;7569.659365328574;7580.279873412017;7588.241175882423;7509.887351689729;7510.474266801271;7513.248675132498;7549.849003019909;7560.508566943158;7383.815404614874;7403.962980185119;7466.25337466249;7468.103827540675;7482.962585187093;32928.83535582331;33146.83426582852;33288.50067248993;33310.66689333124;33372.165695857795;2676.5449873521547;2702.2028501592076;2702.283894767888;2729.863506824671;2734.86325683717;23643.76356236433;23854.761452385428;23902.64146037811;23941.760582394127;24181.395465113514;2538.4274496721137;2551.808614353931;2562.4875024995076;2580.741925807404;2600.7139214686367;126908;129145.35427322898;159911;160007.19996399945;160027;40605.984850378976;40739.59260407358;40883.18233635311;41078.8381742741;41176.794116029225;42933.570664293584;42937.35593966093;42947.57052429436;42950.57049429528;43126.78436607797;12664.176828506117;12846.67883302925;12854.164479308814;12871.871281287255;12877.356132193352;10404.427756473468;10441.477926103664;10457.477126143662;10477.633282835064;10481.580736770597;12772.61682149537;12790.294283816875;12815.551455699006;12888.162269452456;12936.353182340845;5153.793848246029;5366.221897824794;5367.409584945653;5370.785168593213;5415.377231618336;865.9350548708873;889.4974339498162;892.0197162299685;900.7703035725979;927.4296307770672;20016.89991550062;20588.485287867923;21108.577828443344;21228.78771212299;21241;962.6341990043878;966.6278482784038;975.3465178330536;1004.8191325561323;1009.4750729620556;10954.39750813697;11231.775364492665;13865.445382184802;14446.422143114369;14487.565373038826;239836;242853;243162;243931;244120;47313.76343118331;47815.521844781106;47838.28242576364;47913;47999.5200048002;1221.712897469094;1255.9246445213316;1265.8038004109378;1267.6513958661442;1274.8024056271292;23764.762352376947;24439.26682199537;25099.121530746335;25228.621570676823;25263.87368063148;31391.529127063568;31393;31652.208694781893;31658.36683266368;31733.682663173073;237644;239624;239632;239803;240346;28558.286502809897;29795.530670398748;29905.551416729202;30179.698203017688;30467.847660761556;35647.465288021216;35723.64276357203;36214.8189259052;36911;37097.44353834641;27272.86363568249;27382.726172738017;27402.725972740816;28043.298917527223;28216.29459263535;27200;27280.454390912466;28380.57429138606;28445.573316399856;28474.003409880555;30808.53787193149;30825.075247742603;30958.0712578623;31364.529532056582;31824;27485;27755.30611734642;28199.71800281971;28373.290667733472;28374.432511349245;20914.37256882296;22503.437414064778;22522.662160067284;22562.548749025256;22702.205422810122 04:49:03 INFO - PID 16634 | |2;jquery.html;406.63402937356375;414.19852585247565;420.51220584122404;432.7641435417697;433.71591607497083;16514.256858441368;18110.094495275232;18937.71593426098;18952.905235473838;19010.61978760424;16866;17178.226979785908;17224.655506889856;17419;17634.647307053885;5697.145428185764;5745.052066409048;5746.138079288119;5782.3639399666;5868.325142608612;5692.5161361284345;5719.428057194289;5728.541716662678;5763.596548241625;5778.942210577903;5513.751881165357;5703;5718.685472299022;5746.913796293059;5784.13238014297;5739.368669446358;5740.311162660487;5756.539476841843;5770.19217309577;5809.796657117023;5099.923501147486;5236.554892834114;5256.9474305256845;5273.156294992821;5286.20706893969;22512.662310065363;22866.77133228663;22968;22987.195448159233;23191.188308409124;1549.7985261915992;1556.2141118734967;1558.4545409106836;1572.0489104091973;1585.112337091221;13622.93188534061;14403.279836008158;14409.42362305517;14794.501423507058;14967.176805275705;1696.4316953820485;1728.5419363868584;1745.3193254630705;1747.2137538107902;1773.7743298744128;87323.56338218332;89103.10896891014;90466;92135.53932230295;98024.99999999929;10858.077063449695;10926.125909927187;11083.390413527333;11150.163737719704;11327.32036077838;15475.071495710068;15511.612209694622;15534.223288835514;15545.611359715871;15587.61030974212;7583.848323033509;7748.883766743504;7824.491408058458;7970.920290797134;7972.800679983046;7069.575825450489;7092.184398794205;7180.82047948795;7357.668904899292;7373.778786636302;6912.758053468105;7046.612436316052;7129.82175445618;7170.139583250043;7204.639768011579;2036.521417466894;2062.4019034479834;2074.201432448518;2107.8419118566167;2238.876861772618;837.4431003382804;841.6675413211747;856.6316483911978;860.1613426908714;876.8772371867943;16486.34054637801;16786.832131678526;16878.662426751398;17004.744928826076;17605.647887042443;881.6473410635668;882.8146089321186;891.2736120062128;895.6596493332622;906.555787664053;9028.729138125867;10839.586493174706;11601.245919015237;11918.225315354473;12028.218165819193;476989.4515822585;480365;480468;482780;494592;92208.85060172308;92965.53517232371;95532;95579;100382;1065.2330322168027;1091.5524634899652;1116.6984914073316;1134.8638163420442;1138.869030061537;16072.919635401748;16677.416290429777;17686.823131768517;18043.18805653775;18283.085845707927;42366.57633423626;42565.148697025266;42928;43106.78446607747;43336.783316083216;55243.44756552383;56307.436925630216;56724.14913776214;57116.143257851996;57406.425935741776;11170.821689770743;11447.427628618703;12493.562725304571;12558.560450384193;12724.427400766803;13367.732645346845;13596.524121655695;13674.179549227078;13692.589222323346;13783.794592865093;10200.489975501047;10391.168706503613;10496.265261431627;10628.734281642712;11027;10595.735106622396;10607.469626518488;10610.098141658045;10724.571017159225;10812.729681758019;11168.832467513157;11606.941965290458;11634.767304653691;11686.357250351311;11725.589604363806;11456.140789440658;11547.595834145764;11679.416029198335;11848;12158.331291779037;11616.94191529037;11726.237794543327;11813;11973.461194246454;12127.090468214743 04:49:03 INFO - PID 16634 | |3;mootools.html;1242.4098553187234;1269.5873841001676;1286.215408600754;1300.3693208793738;1313.1792629606498;9431.245500359972;9751.70744877653;9829.606815727371;9888.505574721272;10120.898791012087;9877.604895804177;10055.64805231817;10066.949665251681;10071.345362551447;10081.798364032733;2226.1651880544755;2267.886605669718;2271.613825649635;2273.397549649336;2273.8408311418207;2102.9894850525725;2190.59473997311;2195.407240045187;2197.7802219778055;2198.1756841184556;2110.556783075556;2137.081055146294;2154.924577639775;2162.87022778633;2174.7716489768504;2135.1993002624017;2142.9785702142935;2150.290404166621;2155.2133471282946;2161.7838216178416;1864.4127099963468;1925.3550060729672;2106.178590349765;2112.8837913914726;2158.3632828315685;9745.463999480025;9841.163501102343;9847.359921605073;9858.556364963593;9875.753106172404;5281;5484;5493.505584497414;5498.505134537911;5499.945000549983;3275.574175357212;3280.9835950820334;3287.2603664175367;3287.539744435781;3329.9500507492407;1056.4136904018267;1080.0495563903794;1093.5297821936565;1099.9505022274018;1116.3692513729716;14275.999999999896;14318.713625727427;14329.140251584835;14353.138811671333;14417.783733243905;4457.64338852891;4714.481407045222;4843.588294994965;4845.75771211438;4850.466448690711;10595.629152979609;10607.94696026515;10615.416152111708;10627.309224900511;10644.520996555173;5420.539254163361;5434.782608695607;5437.864053398696;5439.619226654097;5448.863778405572;4639.164950308909;4820.132376172252;4939;5000.849974500771;5034.924476132861;3723.1809002019513;3782.1868298315444;3786.6746638676796;3873.24471728016;3914.9021274467796;1121.2599684208383;1134.8865113488584;1142.7200335917753;1153.117864833403;1160.0603511155991;649.162580271454;671.3756206727693;676.7123972311846;677.38019711963;689.1385767790263;5028.120078986236;5034.823781167642;5061.114304996611;5083.389993200765;5095.796168153306;518.9844304670866;524.1456426025554;527.3144911614885;527.3302905310235;532.4010488200774;2935.647722273341;3308.4210263203845;3421.367047096295;3472.5312082868995;3582.1044738815294;12160.817587736192;12816.55142070023;12819.230846149261;12821;12826.294553799444;12072.939635301944;12623.87376126227;12664.620061398173;12665.683357916127;12681;9159.542022898962;9368.4378937264;9381.249500039981;9401.670941517152;9403.4828084456;5640.464155905182;5761.279840019997;5903;5946.762129514771;6157.815265542041;11066.114710822954;11089.722756930818;11382.487788049391;11431.714207144556;11513;11345.773084538429;11414.086873050303;11537.307761534335;11556.306621602731;11627.941860290644;7817.804554886174;7936.761897143095;7950.125486196398;8001.319887809602;8011.599420028859;8955.238804701674;9040.067111413135;9115.27077833785;9138.360314777901;9267.351285409957;7278.708851645875;7347.669354878936;7356.374708149867;7370.410367170506;7403.7408690695565;7085.929140708733;7154.2488038757265;7163.641817909188;7386.96306518464;7415.3326200642205;6616.735330586916;6630.635315057718;6679.799606011828;6716.1604799400075;6723.764668236784;4884.242942343943;4953.331300274417;5035.219540971156;5077.162268225701;5247.55395791362;4814.374131363041;4823.5658790709;4858.514148585114;4973.502649734997;5054.368203974504 04:49:03 INFO - PID 16634 | |4;prototype.html;357.5316335600362;386.86073013715065;392.0395032171181;394.29224541947207;398.5715355992309;5489.258950041743;5611.242482264898;5659.179418984245;5667.263255776743;5670.688112153835;5401.594880383977;5469.234307196995;5472.808451704191;5492.450754924505;5492.862678433041;4257.701960862741;4257.87226383209;4267.082577245899;4267.722598031133;4268.530461649231;4096.139810639769;4245.23585754564;4276.401303817468;4278.9786051069705;4312.719673221231;4230.4500414946015;4253.404523366731;4253.65970722343;4254.85119017865;4258.616724494795;4238.19474299882;4255.893602659928;4268.146370725867;4276.42268293781;4299.484061912559;3529.2764983178386;3746.2882052409955;3751.8499260029566;3757.8684746034032;3761.5298087739034;5397.54120899724;5404.8108316208745;5406.40529541754;5412.323459567554;5444.5916556258435;4909.631777616657;4915.557599815998;4919.532644398776;4923.901521969577;4933.827316043921;5547.306586676666;5807.157962095473;5881.323647780518;5894.823155305347;5895.380984996556;4062.7765472898977;4082.5713300103657;4087.1825634873144;4095.877123686294;4100.938485922714;6010.398960103998;6145.877082458371;6176.4132407421675;6206.534509911775;6248.250209974832;4131.987663022519;4133.689973252018;4156.854510092193;4158.334666453353;4164.354525048622;4229.175310814362;4232.619064284229;4240.38514415408;4240.918565765772;4247.129338485603;4739.66822322441;4834.806607735722;4848.539388758062;4854.17479028566;4870.561649451566;5783.248177736868;5796.47831695141;5796.536277097822;5821.94178058214;5826.708664566755;1448.2830998655522;1460.6713489464785;1461.6857375664283;1463.4585203474783;1464.282501574221;927.2195499262821;968.4237878462303;969.2391472693902;972.7033254857337;988.2439933450916;5083.110455670243;5111.718855462986;5115.232715092766;5116.386033675983;5144.305518754995;6080.361562036011;6088.908666370008;6105.572609917263;6106;6107.8473038173515;4921.311016457699;5050.368703912011;5085.771140298695;5105.897882042338;5114.718690471986;3181.602299712536;3220.760007397169;3224.2584205632834;3228.693274139;3236.8543415546355;5533.501984821305;5637.577181711388;5651.491365777099;5660.518855897212;5679.926826708222;6143.508519318444;6203.7828675997025;6221.377862213742;6230.532710046765;6267.780627678009;5631.943680563142;5652.7173641318595;5652.745626446902;5653.123765816305;5666.9716651416475;5912.408759124053;5991.221141251609;5995.700214989321;6050.848728781815;6106.1146133811235;5931.3178984417345;5957.195778569838;5962.511930520694;5981.3719559445635;6000.21997140369;5454.509094181384;5624.35319938196;5683.403242659627;5686.34607020198;5692.174634678031;4153.397757325231;4153.709240353146;4176.164767046542;4187.769672668032;4189.07840275139;5981.102834574848;6084.209052823105;6134.938650613437;6139.048447490646;6142.477889379453;5824.5340372770925;5887.764489420375;5895;5910.290765108214;5920;5874.559408044328;5908.172855800278;5909.674967876636;5910.379410162043;5913.201717768046;5567.721613919207;5795.652260864362;5802.332731735904;5827.4172582741385;5834.591578589458;5941.405859414024;5956.791512297049;5966.522678185648;5974.133750606051;5979;5530.529904957963;5685.687287199078;5749.9712501437225;5763.415060858129;5778.104393818797 04:49:03 INFO - PID 16634 | |5;yui.html;606.0908637044433;612.7334609444891;615.8860610787004;625.7590827531399;639.2041907824758;12393.504259829608;12679.302638354899;12737.363131843395;12751.234925904453;12860.742785144292;13576.592702218924;13613.795793063113;13624;13662.590122296348;13764.449422023132;877.118495911608;893.5442924108719;899.3614533681094;903.7559858838109;904.1139683110556;911.4485736129645;912.3659056955419;912.7353067610385;912.9954350228239;923.1276443760648;951.1724799424476;951.2295041016798;951.4719330771454;955.8327292723781;966.1884017425361;934.9392289501161;941.0683423410842;944.2304521814733;945.4799860076964;948.4925564822821;688.7658196213262;693.3482526425145;694.944404447643;695.513140801436;706.2795948132926;13623.659408514768;13865.722685546334;14228;14285.857141428556;14311;12873.356332183354;13405.195688258638;13517.526886558922;13708;13914.791278130837;8802.735917922473;8986.326025548111;9060.184583387461;9093.545322733837;9258.213051890598;2357.3870793593787;2360.988195059031;2367.869767162805;2426.3206302235403;2432.2946345559767;56976.430235697524;57642.423575764544;58494.41505584932;58673.53316167087;59380;9180.6786762463;9188.95405522968;9800.607975680892;10136.797264054678;10261.076503114606;20630.27794027202;21193;21410.892945535485;21427.250046248617;21650.891745541172;6229.127922090911;6236.844078898064;6336.429721325103;6433.099366088752;6591.6374599397495;2818.675852277014;2952.232419570884;2980.3890202508433;3001.384716133231;3021.8640161192798;3402.863885444604;3457.239407330383;3469.670381313771;3480.7911525308564;3482.930341393158;658.2265837640753;658.5719282466436;660.0594153331483;664.9335066493312;681.6080753566719;468.4261779320373;469.4999825186166;470.77402846633123;482.75379556426475;491.037566369919;6638.535302528873;6694.665266736741;6901;7015;7037.894431583531;475.1328824894581;496.91055609989826;502.8214983680814;506.3695698854949;513.9897202055938;3375.6624337566536;3393.5418718473184;3423.5720534933134;3480.4953281774;3524.1189702574356;65374.67312663501;65392.67303663546;65476;65993.34006659871;68479.65760171266;57215;57834.42165578374;57884;58663.70668146632;58932.41067589355;48490.272645910336;49243.26135107976;49338;50249.74875125601;50907.745461273196;6681.732730690913;8348.364853723591;8366.790830229293;8525.87211191845;8639.611217495101;25167.496650067264;25260.242192734248;25509.61735574005;26332.736672633793;26707.06525271606;44051;44265.557344426146;46371.76814116043;46413.535864642276;46693.53306467028;9824.950875245579;9929.3545919515;9986;10002.199824014207;10494.370337779757;10500.264981451224;10503.894961050291;10570.471476425993;10678.359298442118;11130.666080017612;10932.398718070583;11160.10719142483;11293.943530282297;11703.356315402394;11764.117691173367;11244.498398853284;11371;11392.715182120513;11474.403445814616;11523.193376463567;10166.542505587118;10604.787904242026;10618.52216650268;10633.255672103189;10958.068564172134;7769.689212431439;7853.293203611703;8095.2714255717265;8268.09051004401;8540.14598540141;8219.83560328802;8232.300254478436;8419.915800841913;8452.915470845213;8483.406161568631 04:49:03 INFO - PID 16634 | __end_tp_report 04:49:03 INFO - PID 16634 | __start_cc_report 04:49:03 INFO - PID 16634 | _x_x_mozilla_cycle_collect,398 04:49:03 INFO - PID 16634 | __end_cc_report 04:49:03 INFO - PID 16634 | __startTimestamp1490960943846__endTimestamp 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | ------- Summary: start ------- 04:49:03 INFO - PID 16634 | Number of tests: 6 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#0] dojo.html Cycles:165 Average:5169.89 Median:5312.12 stddev:589.27 (11.1%) stddev-sans-first:558.03 04:49:03 INFO - PID 16634 | Values: 2689.3 2718.4 2726.8 2738.0 2748.4 5109.2 5196.6 5258.9 5262.4 5314.2 5180.4 5215.3 5215.6 5306.9 5341.3 4796.8 4820.9 4834.4 4846.1 4866.9 4839.5 4877.6 4890.8 4898.0 4923.7 4651.3 4700.3 4741.2 4811.5 4823.6 4722.0 4747.7 4748.4 4792.5 4794.0 4639.2 4708.9 4715.9 4740.4 4746.8 5060.1 5127.9 5163.2 5165.9 5182.2 5649.6 5658.2 5686.6 5711.8 5714.8 5687.0 5691.7 5701.1 5704.4 5711.5 5170.2 5273.7 5281.7 5282.1 5351.4 5760.7 5819.9 5873.9 5887.4 5891.0 5404.4 5470.2 5539.9 5556.9 5589.8 5628.2 5659.6 5661.4 5665.9 5675.5 5462.5 5625.9 5629.5 5631.1 5640.3 5488.4 5493.1 5493.2 5494.0 5497.9 4686.9 4688.6 4689.9 4694.2 4697.6 4060.3 4079.5 4086.9 4088.3 4089.1 4756.5 4764.8 4766.3 4767.0 4775.3 5518.9 5569.9 5572.0 5572.6 5581.9 4721.8 4749.5 4765.1 4776.4 4779.9 5004.9 5046.6 5063.0 5067.8 5068.0 5294.9 5295.5 5295.9 5302.4 5341.2 5539.8 5602.7 5651.1 5680.8 5685.1 5269.0 5270.2 5273.9 5285.8 5312.1 5555.4 5561.5 5566.1 5572.8 5625.0 5499.1 5554.6 5647.4 5651.7 5670.7 5474.3 5479.7 5481.3 5508.9 5534.1 5441.2 5455.6 5461.0 5464.5 5467.2 5265.9 5330.9 5368.8 5404.2 5463.3 5508.4 5534.3 5567.6 5575.9 5585.8 5274.3 5375.4 5376.8 5425.6 5436.9 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#1] ext.html Cycles:180 Average:35278.75 Median:29850.54 stddev:56009.94 (187.6%) stddev-sans-first:56106.52 04:49:03 INFO - PID 16634 | Values: 595.4 662.7 686.1 1203.9 1216.7 34948.3 36318.1 36342.1 36406.8 36410.6 33866.7 34139.3 34276.3 34344.7 34383.8 7335.1 7526.2 7527.5 7527.6 7529.7 7463.3 7505.8 7528.0 7546.7 7559.2 7522.8 7552.3 7569.7 7580.3 7588.2 7509.9 7510.5 7513.2 7549.8 7560.5 7383.8 7404.0 7466.3 7468.1 7483.0 32928.8 33146.8 33288.5 33310.7 33372.2 2676.5 2702.2 2702.3 2729.9 2734.9 23643.8 23854.8 23902.6 23941.8 24181.4 2538.4 2551.8 2562.5 2580.7 2600.7 126908.0 129145.4 159911.0 160007.2 160027.0 40606.0 40739.6 40883.2 41078.8 41176.8 42933.6 42937.4 42947.6 42950.6 43126.8 12664.2 12846.7 12854.2 12871.9 12877.4 10404.4 10441.5 10457.5 10477.6 10481.6 12772.6 12790.3 12815.6 12888.2 12936.4 5153.8 5366.2 5367.4 5370.8 5415.4 865.9 889.5 892.0 900.8 927.4 20016.9 20588.5 21108.6 21228.8 21241.0 962.6 966.6 975.3 1004.8 1009.5 10954.4 11231.8 13865.4 14446.4 14487.6 239836.0 242853.0 243162.0 243931.0 244120.0 47313.8 47815.5 47838.3 47913.0 47999.5 1221.7 1255.9 1265.8 1267.7 1274.8 23764.8 24439.3 25099.1 25228.6 25263.9 31391.5 31393.0 31652.2 31658.4 31733.7 237644.0 239624.0 239632.0 239803.0 240346.0 28558.3 29795.5 29905.6 30179.7 30467.8 35647.5 35723.6 36214.8 36911.0 37097.4 27272.9 27382.7 27402.7 28043.3 28216.3 27200.0 27280.5 28380.6 28445.6 28474.0 30808.5 30825.1 30958.1 31364.5 31824.0 27485.0 27755.3 28199.7 28373.3 28374.4 20914.4 22503.4 22522.7 22562.5 22702.2 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#2] jquery.html Cycles:180 Average:29310.64 Median:2049.46 stddev:79924.46 (3899.8%) stddev-sans-first:80119.20 04:49:03 INFO - PID 16634 | Values: 406.6 414.2 420.5 432.8 433.7 16514.3 18110.1 18937.7 18952.9 19010.6 16866.0 17178.2 17224.7 17419.0 17634.6 5697.1 5745.1 5746.1 5782.4 5868.3 5692.5 5719.4 5728.5 5763.6 5778.9 5513.8 5703.0 5718.7 5746.9 5784.1 5739.4 5740.3 5756.5 5770.2 5809.8 5099.9 5236.6 5256.9 5273.2 5286.2 22512.7 22866.8 22968.0 22987.2 23191.2 1549.8 1556.2 1558.5 1572.0 1585.1 13622.9 14403.3 14409.4 14794.5 14967.2 1696.4 1728.5 1745.3 1747.2 1773.8 87323.6 89103.1 90466.0 92135.5 98025.0 10858.1 10926.1 11083.4 11150.2 11327.3 15475.1 15511.6 15534.2 15545.6 15587.6 7583.8 7748.9 7824.5 7970.9 7972.8 7069.6 7092.2 7180.8 7357.7 7373.8 6912.8 7046.6 7129.8 7170.1 7204.6 2036.5 2062.4 2074.2 2107.8 2238.9 837.4 841.7 856.6 860.2 876.9 16486.3 16786.8 16878.7 17004.7 17605.6 881.6 882.8 891.3 895.7 906.6 9028.7 10839.6 11601.2 11918.2 12028.2 476989.5 480365.0 480468.0 482780.0 494592.0 92208.9 92965.5 95532.0 95579.0 100382.0 1065.2 1091.6 1116.7 1134.9 1138.9 16072.9 16677.4 17686.8 18043.2 18283.1 42366.6 42565.1 42928.0 43106.8 43336.8 55243.4 56307.4 56724.1 57116.1 57406.4 11170.8 11447.4 12493.6 12558.6 12724.4 13367.7 13596.5 13674.2 13692.6 13783.8 10200.5 10391.2 10496.3 10628.7 11027.0 10595.7 10607.5 10610.1 10724.6 10812.7 11168.8 11606.9 11634.8 11686.4 11725.6 11456.1 11547.6 11679.4 11848.0 12158.3 11616.9 11726.2 11813.0 11973.5 12127.1 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#3] mootools.html Cycles:180 Average:6045.66 Median:4548.40 stddev:3879.36 (85.3%) stddev-sans-first:3873.45 04:49:03 INFO - PID 16634 | Values: 1242.4 1269.6 1286.2 1300.4 1313.2 9431.2 9751.7 9829.6 9888.5 10120.9 9877.6 10055.6 10066.9 10071.3 10081.8 2226.2 2267.9 2271.6 2273.4 2273.8 2103.0 2190.6 2195.4 2197.8 2198.2 2110.6 2137.1 2154.9 2162.9 2174.8 2135.2 2143.0 2150.3 2155.2 2161.8 1864.4 1925.4 2106.2 2112.9 2158.4 9745.5 9841.2 9847.4 9858.6 9875.8 5281.0 5484.0 5493.5 5498.5 5499.9 3275.6 3281.0 3287.3 3287.5 3330.0 1056.4 1080.0 1093.5 1100.0 1116.4 14276.0 14318.7 14329.1 14353.1 14417.8 4457.6 4714.5 4843.6 4845.8 4850.5 10595.6 10607.9 10615.4 10627.3 10644.5 5420.5 5434.8 5437.9 5439.6 5448.9 4639.2 4820.1 4939.0 5000.8 5034.9 3723.2 3782.2 3786.7 3873.2 3914.9 1121.3 1134.9 1142.7 1153.1 1160.1 649.2 671.4 676.7 677.4 689.1 5028.1 5034.8 5061.1 5083.4 5095.8 519.0 524.1 527.3 527.3 532.4 2935.6 3308.4 3421.4 3472.5 3582.1 12160.8 12816.6 12819.2 12821.0 12826.3 12072.9 12623.9 12664.6 12665.7 12681.0 9159.5 9368.4 9381.2 9401.7 9403.5 5640.5 5761.3 5903.0 5946.8 6157.8 11066.1 11089.7 11382.5 11431.7 11513.0 11345.8 11414.1 11537.3 11556.3 11627.9 7817.8 7936.8 7950.1 8001.3 8011.6 8955.2 9040.1 9115.3 9138.4 9267.4 7278.7 7347.7 7356.4 7370.4 7403.7 7085.9 7154.2 7163.6 7387.0 7415.3 6616.7 6630.6 6679.8 6716.2 6723.8 4884.2 4953.3 5035.2 5077.2 5247.6 4814.4 4823.6 4858.5 4973.5 5054.4 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#4] prototype.html Cycles:180 Average:4836.44 Median:5492.66 stddev:1430.34 (26.0%) stddev-sans-first:1394.28 04:49:03 INFO - PID 16634 | Values: 357.5 386.9 392.0 394.3 398.6 5489.3 5611.2 5659.2 5667.3 5670.7 5401.6 5469.2 5472.8 5492.5 5492.9 4257.7 4257.9 4267.1 4267.7 4268.5 4096.1 4245.2 4276.4 4279.0 4312.7 4230.5 4253.4 4253.7 4254.9 4258.6 4238.2 4255.9 4268.1 4276.4 4299.5 3529.3 3746.3 3751.8 3757.9 3761.5 5397.5 5404.8 5406.4 5412.3 5444.6 4909.6 4915.6 4919.5 4923.9 4933.8 5547.3 5807.2 5881.3 5894.8 5895.4 4062.8 4082.6 4087.2 4095.9 4100.9 6010.4 6145.9 6176.4 6206.5 6248.3 4132.0 4133.7 4156.9 4158.3 4164.4 4229.2 4232.6 4240.4 4240.9 4247.1 4739.7 4834.8 4848.5 4854.2 4870.6 5783.2 5796.5 5796.5 5821.9 5826.7 1448.3 1460.7 1461.7 1463.5 1464.3 927.2 968.4 969.2 972.7 988.2 5083.1 5111.7 5115.2 5116.4 5144.3 6080.4 6088.9 6105.6 6106.0 6107.8 4921.3 5050.4 5085.8 5105.9 5114.7 3181.6 3220.8 3224.3 3228.7 3236.9 5533.5 5637.6 5651.5 5660.5 5679.9 6143.5 6203.8 6221.4 6230.5 6267.8 5631.9 5652.7 5652.7 5653.1 5667.0 5912.4 5991.2 5995.7 6050.8 6106.1 5931.3 5957.2 5962.5 5981.4 6000.2 5454.5 5624.4 5683.4 5686.3 5692.2 4153.4 4153.7 4176.2 4187.8 4189.1 5981.1 6084.2 6134.9 6139.0 6142.5 5824.5 5887.8 5895.0 5910.3 5920.0 5874.6 5908.2 5909.7 5910.4 5913.2 5567.7 5795.7 5802.3 5827.4 5834.6 5941.4 5956.8 5966.5 5974.1 5979.0 5530.5 5685.7 5750.0 5763.4 5778.1 04:49:03 INFO - PID 16634 | 04:49:03 INFO - PID 16634 | [#5] yui.html Cycles:180 Average:14116.09 Median:25378.06 stddev:17887.67 (70.5%) stddev-sans-first:17909.08 04:49:03 INFO - PID 16634 | Values: 606.1 612.7 615.9 625.8 639.2 12393.5 12679.3 12737.4 12751.2 12860.7 13576.6 13613.8 13624.0 13662.6 13764.4 877.1 893.5 899.4 903.8 904.1 911.4 912.4 912.7 913.0 923.1 951.2 951.2 951.5 955.8 966.2 934.9 941.1 944.2 945.5 948.5 688.8 693.3 694.9 695.5 706.3 13623.7 13865.7 14228.0 14285.9 14311.0 12873.4 13405.2 13517.5 13708.0 13914.8 8802.7 8986.3 9060.2 9093.5 9258.2 2357.4 2361.0 2367.9 2426.3 2432.3 56976.4 57642.4 58494.4 58673.5 59380.0 9180.7 9189.0 9800.6 10136.8 10261.1 20630.3 21193.0 21410.9 21427.3 21650.9 6229.1 6236.8 6336.4 6433.1 6591.6 2818.7 2952.2 2980.4 3001.4 3021.9 3402.9 3457.2 3469.7 3480.8 3482.9 658.2 658.6 660.1 664.9 681.6 468.4 469.5 470.8 482.8 491.0 6638.5 6694.7 6901.0 7015.0 7037.9 475.1 496.9 502.8 506.4 514.0 3375.7 3393.5 3423.6 3480.5 3524.1 65374.7 65392.7 65476.0 65993.3 68479.7 57215.0 57834.4 57884.0 58663.7 58932.4 48490.3 49243.3 49338.0 50249.7 50907.7 6681.7 8348.4 8366.8 8525.9 8639.6 25167.5 25260.2 25509.6 26332.7 26707.1 44051.0 44265.6 46371.8 46413.5 46693.5 9825.0 9929.4 9986.0 10002.2 10494.4 10500.3 10503.9 10570.5 10678.4 11130.7 10932.4 11160.1 11293.9 11703.4 11764.1 11244.5 11371.0 11392.7 11474.4 11523.2 10166.5 10604.8 10618.5 10633.3 10958.1 7769.7 7853.3 8095.3 8268.1 8540.1 8219.8 8232.3 8419.9 8452.9 8483.4 04:49:03 INFO - PID 16634 | -------- Summary: end -------- 04:49:03 INFO - PID 16634 | 04:49:04 INFO - TEST-INFO | 16634: exit 0 04:49:04 INFO - TEST-OK | dromaeo_css | took 1120987ms 04:49:04 INFO - TEST-START | kraken 04:49:04 INFO - operating with platform_type : linux_ 04:49:04 INFO - Initialising browser for kraken test... 04:49:04 INFO - TEST-INFO | started process 17022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgpDSia/profile http://localhost:58850/getInfo.html) 04:49:08 INFO - PID 17022 | __metrics Screen width/height:1600/1200 04:49:08 INFO - PID 17022 | colorDepth:24 04:49:08 INFO - PID 17022 | Browser inner width/height: 1024/697 04:49:08 INFO - PID 17022 | __metrics 04:49:09 ERROR - PID 17022 | 1490960949678 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/tmpgpDSia/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpgpDSia/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpgpDSia/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpgpDSia/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:49:09 ERROR - PID 17022 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:49:10 INFO - TEST-INFO | 17022: exit 0 04:49:10 INFO - Browser initialized. 04:49:10 INFO - Running cycle 1/1 for kraken test... 04:49:10 INFO - TEST-INFO | started process 17153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgpDSia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:22 INFO - PID 17153 | RSS: Main: 155762688 04:49:22 INFO - PID 17153 | 04:49:25 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58850/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:26 INFO - PID 17153 | RSS: Main: 163094528 04:49:26 INFO - PID 17153 | 04:49:29 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58850/tests/kraken/driver.html?testName=audio-dft) 04:49:29 INFO - PID 17153 | RSS: Main: 161550336 04:49:29 INFO - PID 17153 | 04:49:32 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58850/tests/kraken/driver.html?testName=audio-fft) 04:49:33 INFO - PID 17153 | RSS: Main: 157622272 04:49:33 INFO - PID 17153 | 04:49:35 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58850/tests/kraken/driver.html?testName=audio-oscillator) 04:49:36 INFO - PID 17153 | RSS: Main: 158052352 04:49:36 INFO - PID 17153 | 04:49:38 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:39 INFO - PID 17153 | RSS: Main: 158896128 04:49:39 INFO - PID 17153 | 04:49:42 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58850/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:43 INFO - PID 17153 | RSS: Main: 163680256 04:49:43 INFO - PID 17153 | 04:49:46 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58850/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:47 INFO - PID 17153 | RSS: Main: 161574912 04:49:47 INFO - PID 17153 | 04:49:50 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58850/tests/kraken/driver.html?testName=json-parse-financial) 04:49:50 INFO - PID 17153 | RSS: Main: 162476032 04:49:50 INFO - PID 17153 | 04:49:52 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:53 INFO - PID 17153 | RSS: Main: 162627584 04:49:53 INFO - PID 17153 | 04:49:55 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:55 INFO - PID 17153 | RSS: Main: 162324480 04:49:55 INFO - PID 17153 | 04:49:58 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:58 INFO - PID 17153 | RSS: Main: 163504128 04:49:58 INFO - PID 17153 | 04:50:01 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:02 INFO - PID 17153 | RSS: Main: 164118528 04:50:02 INFO - PID 17153 | 04:50:05 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:06 INFO - PID 17153 | RSS: Main: 163401728 04:50:06 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | Cycle 1(1): loaded http://localhost:58850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58850/tests/kraken/driver.html?testName=ai-astar) 04:50:08 INFO - PID 17153 | RSS: Main: 165515264 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | __start_tp_report 04:50:08 INFO - PID 17153 | _x_x_mozilla_page_load 04:50:08 INFO - PID 17153 | _x_x_mozilla_page_load_details 04:50:08 INFO - PID 17153 | |i|pagename|runs| 04:50:08 INFO - PID 17153 | |0;ai-astar;102;116;113;112;113;111;111;112;111;113 04:50:08 INFO - PID 17153 | |1;audio-beat-detection;155;131;125;167;124;126;126;126;155;125 04:50:08 INFO - PID 17153 | |2;audio-dft;168;166;169;172;169;168;165;165;166;165 04:50:08 INFO - PID 17153 | |3;audio-fft;76;75;76;122;76;75;79;76;93;78 04:50:08 INFO - PID 17153 | |4;audio-oscillator;85;85;120;85;85;84;112;85;85;108 04:50:08 INFO - PID 17153 | |5;imaging-gaussian-blur;114;114;114;115;115;122;115;115;115;115 04:50:08 INFO - PID 17153 | |6;imaging-darkroom;150;151;152;152;152;152;151;158;151;151 04:50:08 INFO - PID 17153 | |7;imaging-desaturate;95;96;94;94;95;95;101;95;97;95 04:50:08 INFO - PID 17153 | |8;json-parse-financial;68;69;67;71;69;70;72;70;72;69 04:50:08 INFO - PID 17153 | |9;json-stringify-tinderbox;56;56;58;57;56;56;56;56;57;57 04:50:08 INFO - PID 17153 | |10;stanford-crypto-aes;87;85;84;85;85;90;84;83;83;83 04:50:08 INFO - PID 17153 | |11;stanford-crypto-ccm;136;141;136;153;138;135;142;142;197;139 04:50:08 INFO - PID 17153 | |12;stanford-crypto-pbkdf2;189;197;197;193;200;197;197;198;197;197 04:50:08 INFO - PID 17153 | |13;stanford-crypto-sha256-iterative;72;72;73;71;72;71;70;73;71;76 04:50:08 INFO - PID 17153 | __end_tp_report 04:50:08 INFO - PID 17153 | __start_cc_report 04:50:08 INFO - PID 17153 | _x_x_mozilla_cycle_collect,893 04:50:08 INFO - PID 17153 | __end_cc_report 04:50:08 INFO - PID 17153 | __startTimestamp1490961008301__endTimestamp 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | ------- Summary: start ------- 04:50:08 INFO - PID 17153 | Number of tests: 14 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.63 (3.2%) stddev-sans-first:1.59 04:50:08 INFO - PID 17153 | Values: 102.0 116.0 113.0 112.0 113.0 111.0 111.0 112.0 111.0 113.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.50 stddev:16.31 (12.7%) stddev-sans-first:15.78 04:50:08 INFO - PID 17153 | Values: 155.0 131.0 125.0 167.0 124.0 126.0 126.0 126.0 155.0 125.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#2] audio-dft Cycles:10 Average:167.30 Median:168.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 04:50:08 INFO - PID 17153 | Values: 168.0 166.0 169.0 172.0 169.0 168.0 165.0 165.0 166.0 165.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.85 (19.5%) stddev-sans-first:15.56 04:50:08 INFO - PID 17153 | Values: 76.0 75.0 76.0 122.0 76.0 75.0 79.0 76.0 93.0 78.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:85.00 stddev:14.06 (16.5%) stddev-sans-first:14.58 04:50:08 INFO - PID 17153 | Values: 85.0 85.0 120.0 85.0 85.0 84.0 112.0 85.0 85.0 108.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:2.37 (2.1%) stddev-sans-first:2.46 04:50:08 INFO - PID 17153 | Values: 114.0 114.0 114.0 115.0 115.0 122.0 115.0 115.0 115.0 115.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.00 stddev:2.21 (1.5%) stddev-sans-first:2.22 04:50:08 INFO - PID 17153 | Values: 150.0 151.0 152.0 152.0 152.0 152.0 151.0 158.0 151.0 151.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.06 (2.2%) stddev-sans-first:2.17 04:50:08 INFO - PID 17153 | Values: 95.0 96.0 94.0 94.0 95.0 95.0 101.0 95.0 97.0 95.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#8] json-parse-financial Cycles:10 Average:69.70 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.62 04:50:08 INFO - PID 17153 | Values: 68.0 69.0 67.0 71.0 69.0 70.0 72.0 70.0 72.0 69.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 04:50:08 INFO - PID 17153 | Values: 56.0 56.0 58.0 57.0 56.0 56.0 56.0 56.0 57.0 57.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:2.18 (2.6%) stddev-sans-first:2.18 04:50:08 INFO - PID 17153 | Values: 87.0 85.0 84.0 85.0 85.0 90.0 84.0 83.0 83.0 83.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:141.50 stddev:18.68 (13.2%) stddev-sans-first:19.47 04:50:08 INFO - PID 17153 | Values: 136.0 141.0 136.0 153.0 138.0 135.0 142.0 142.0 197.0 139.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:197.00 stddev:3.05 (1.5%) stddev-sans-first:1.80 04:50:08 INFO - PID 17153 | Values: 189.0 197.0 197.0 193.0 200.0 197.0 197.0 198.0 197.0 197.0 04:50:08 INFO - PID 17153 | 04:50:08 INFO - PID 17153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.66 (2.3%) stddev-sans-first:1.76 04:50:08 INFO - PID 17153 | Values: 72.0 72.0 73.0 71.0 72.0 71.0 70.0 73.0 71.0 76.0 04:50:08 INFO - PID 17153 | -------- Summary: end -------- 04:50:08 INFO - PID 17153 | 04:50:09 INFO - TEST-INFO | 17153: exit 0 04:50:09 INFO - TEST-OK | kraken | took 64978ms 04:50:09 INFO - SUITE-END | took 1185s 04:50:09 INFO - Completed test suite (00:19:46) 04:50:09 INFO - javascript benchmark 04:50:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6659.268212535728, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.327668082979, 2718.4291298827247, 2726.781857451404, 2737.958930616041, 2748.4365705030473, 5109.182530795074, 5196.558292545138, 5258.921116183255, 5262.421133675302, 5314.229436731672, 5180.430152683211, 5215.322008138936, 5215.58275337973, 5306.893862122755, 5341.252224688546, 4796.784144713479, 4820.903581928359, 4834.371531700874, 4846.0550192712435, 4866.926996095061, 4839.516048395168, 4877.634177436688, 4890.828820991266, 4898.02039592083, 4923.70457772533, 4651.302304654295, 4700.29495575663, 4741.170295198361, 4811.494793046715, 4823.638227132979, 4722.0, 4747.6914000590195, 4748.3589715388325, 4792.520747925215, 4794.0, 4639.188142075157, 4708.929366059512, 4715.905681886343, 4740.360051393052, 4746.786394612216, 5060.139776238048, 5127.897442051175, 5163.225516172567, 5165.896682066375, 5182.2485739567555, 5649.604527683064, 5658.236138121342, 5686.601937864351, 5711.7715291388295, 5714.771409143629, 5686.971565142189, 5691.743871525791, 5701.059325211335, 5704.429557044304, 5711.485966263015, 5170.1986192140275, 5273.6572122811895, 5281.709505977208, 5282.075636763551, 5351.357837059578, 5760.654360738369, 5819.94180058194, 5873.941260587425, 5887.381824908323, 5891.027980383275, 5404.3784964728775, 5470.17947307907, 5539.861503462445, 5556.888862222733, 5589.776408943678, 5628.240187574707, 5659.5755318351285, 5661.433856614306, 5665.915011274834, 5675.489205971482, 5462.5083742462575, 5625.8593535161945, 5629.549636029108, 5631.070873305941, 5640.266765320482, 5488.423715509894, 5493.093639549509, 5493.2034854945805, 5494.0, 5497.917531237034, 4686.882827929261, 4688.578027977498, 4689.882752931136, 4694.201985662446, 4697.577218050324, 4060.309747342959, 4079.4900637420324, 4086.8773936781945, 4088.34586466164, 4089.1003979124544, 4756.453007904066, 4764.785584648699, 4766.308885211625, 4766.976165119152, 4775.331453596499, 5518.889622207614, 5569.944300557024, 5572.0, 5572.637778544382, 5581.944180558143, 4721.787519561628, 4749.525047495292, 4765.142274390643, 4776.379070720854, 4779.904401912012, 5004.949950500449, 5046.596272298208, 5062.974685126551, 5067.847964561069, 5068.0, 5294.894102117859, 5295.4969277918535, 5295.920561191509, 5302.390225124083, 5341.198820177005, 5539.750711218086, 5602.691851948019, 5651.095824668033, 5680.77276908919, 5685.147227915681, 5268.9736551317, 5270.23581580661, 5273.947260527346, 5285.814996475105, 5312.123499622519, 5555.416681248411, 5561.499465048003, 5566.137248726453, 5572.777088916398, 5624.971875140598, 5499.120140777456, 5554.583406244467, 5647.407022262768, 5651.689157096234, 5670.716464176857, 5474.315710536183, 5479.726013699219, 5481.287432633732, 5508.889822203613, 5534.08687566547, 5441.238226648194, 5455.645383050089, 5460.972695136499, 5464.480874316933, 5467.234587157881, 5265.921011184759, 5330.946690533045, 5368.772488409586, 5404.189371594292, 5463.31708536433, 5508.421615730451, 5534.280543529316, 5567.5545956322585, 5575.944240557705, 5585.776568937197, 5274.314339135888, 5375.381831089475, 5376.838694839161, 5425.593080518898, 5436.918446223231], "value": 5127.78517312637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.359988012886, 662.652107643487, 686.0703746423596, 1203.8916497515222, 1216.659335386091, 34948.3010339793, 36318.09204769882, 36342.091447713785, 36406.817965910166, 36410.635893641054, 33866.661333386655, 34139.31721365571, 34276.31447371051, 34344.656553434455, 34383.828080859625, 7335.119785625706, 7526.247375262457, 7527.548347099164, 7527.5859827709455, 7529.698812047539, 7463.3283004529585, 7505.849883002364, 7527.962360188191, 7546.69813207471, 7559.244075592424, 7522.774316770478, 7552.2825331593685, 7569.659365328574, 7580.279873412017, 7588.241175882423, 7509.887351689729, 7510.474266801271, 7513.248675132498, 7549.849003019909, 7560.508566943158, 7383.815404614874, 7403.962980185119, 7466.25337466249, 7468.103827540675, 7482.962585187093, 32928.83535582331, 33146.83426582852, 33288.50067248993, 33310.66689333124, 33372.165695857795, 2676.5449873521547, 2702.2028501592076, 2702.283894767888, 2729.863506824671, 2734.86325683717, 23643.76356236433, 23854.761452385428, 23902.64146037811, 23941.760582394127, 24181.395465113514, 2538.4274496721137, 2551.808614353931, 2562.4875024995076, 2580.741925807404, 2600.7139214686367, 126908.0, 129145.35427322898, 159911.0, 160007.19996399945, 160027.0, 40605.984850378976, 40739.59260407358, 40883.18233635311, 41078.8381742741, 41176.794116029225, 42933.570664293584, 42937.35593966093, 42947.57052429436, 42950.57049429528, 43126.78436607797, 12664.176828506117, 12846.67883302925, 12854.164479308814, 12871.871281287255, 12877.356132193352, 10404.427756473468, 10441.477926103664, 10457.477126143662, 10477.633282835064, 10481.580736770597, 12772.61682149537, 12790.294283816875, 12815.551455699006, 12888.162269452456, 12936.353182340845, 5153.793848246029, 5366.221897824794, 5367.409584945653, 5370.785168593213, 5415.377231618336, 865.9350548708873, 889.4974339498162, 892.0197162299685, 900.7703035725979, 927.4296307770672, 20016.89991550062, 20588.485287867923, 21108.577828443344, 21228.78771212299, 21241.0, 962.6341990043878, 966.6278482784038, 975.3465178330536, 1004.8191325561323, 1009.4750729620556, 10954.39750813697, 11231.775364492665, 13865.445382184802, 14446.422143114369, 14487.565373038826, 239836.0, 242853.0, 243162.0, 243931.0, 244120.0, 47313.76343118331, 47815.521844781106, 47838.28242576364, 47913.0, 47999.5200048002, 1221.712897469094, 1255.9246445213316, 1265.8038004109378, 1267.6513958661442, 1274.8024056271292, 23764.762352376947, 24439.26682199537, 25099.121530746335, 25228.621570676823, 25263.87368063148, 31391.529127063568, 31393.0, 31652.208694781893, 31658.36683266368, 31733.682663173073, 237644.0, 239624.0, 239632.0, 239803.0, 240346.0, 28558.286502809897, 29795.530670398748, 29905.551416729202, 30179.698203017688, 30467.847660761556, 35647.465288021216, 35723.64276357203, 36214.8189259052, 36911.0, 37097.44353834641, 27272.86363568249, 27382.726172738017, 27402.725972740816, 28043.298917527223, 28216.29459263535, 27200.0, 27280.454390912466, 28380.57429138606, 28445.573316399856, 28474.003409880555, 30808.53787193149, 30825.075247742603, 30958.0712578623, 31364.529532056582, 31824.0, 27485.0, 27755.30611734642, 28199.71800281971, 28373.290667733472, 28374.432511349245, 20914.37256882296, 22503.437414064778, 22522.662160067284, 22562.548749025256, 22702.205422810122], "value": 15207.352100536551, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.63402937356375, 414.19852585247565, 420.51220584122404, 432.7641435417697, 433.71591607497083, 16514.256858441368, 18110.094495275232, 18937.71593426098, 18952.905235473838, 19010.61978760424, 16866.0, 17178.226979785908, 17224.655506889856, 17419.0, 17634.647307053885, 5697.145428185764, 5745.052066409048, 5746.138079288119, 5782.3639399666, 5868.325142608612, 5692.5161361284345, 5719.428057194289, 5728.541716662678, 5763.596548241625, 5778.942210577903, 5513.751881165357, 5703.0, 5718.685472299022, 5746.913796293059, 5784.13238014297, 5739.368669446358, 5740.311162660487, 5756.539476841843, 5770.19217309577, 5809.796657117023, 5099.923501147486, 5236.554892834114, 5256.9474305256845, 5273.156294992821, 5286.20706893969, 22512.662310065363, 22866.77133228663, 22968.0, 22987.195448159233, 23191.188308409124, 1549.7985261915992, 1556.2141118734967, 1558.4545409106836, 1572.0489104091973, 1585.112337091221, 13622.93188534061, 14403.279836008158, 14409.42362305517, 14794.501423507058, 14967.176805275705, 1696.4316953820485, 1728.5419363868584, 1745.3193254630705, 1747.2137538107902, 1773.7743298744128, 87323.56338218332, 89103.10896891014, 90466.0, 92135.53932230295, 98024.99999999929, 10858.077063449695, 10926.125909927187, 11083.390413527333, 11150.163737719704, 11327.32036077838, 15475.071495710068, 15511.612209694622, 15534.223288835514, 15545.611359715871, 15587.61030974212, 7583.848323033509, 7748.883766743504, 7824.491408058458, 7970.920290797134, 7972.800679983046, 7069.575825450489, 7092.184398794205, 7180.82047948795, 7357.668904899292, 7373.778786636302, 6912.758053468105, 7046.612436316052, 7129.82175445618, 7170.139583250043, 7204.639768011579, 2036.521417466894, 2062.4019034479834, 2074.201432448518, 2107.8419118566167, 2238.876861772618, 837.4431003382804, 841.6675413211747, 856.6316483911978, 860.1613426908714, 876.8772371867943, 16486.34054637801, 16786.832131678526, 16878.662426751398, 17004.744928826076, 17605.647887042443, 881.6473410635668, 882.8146089321186, 891.2736120062128, 895.6596493332622, 906.555787664053, 9028.729138125867, 10839.586493174706, 11601.245919015237, 11918.225315354473, 12028.218165819193, 476989.4515822585, 480365.0, 480468.0, 482780.0, 494592.0, 92208.85060172308, 92965.53517232371, 95532.0, 95579.0, 100382.0, 1065.2330322168027, 1091.5524634899652, 1116.6984914073316, 1134.8638163420442, 1138.869030061537, 16072.919635401748, 16677.416290429777, 17686.823131768517, 18043.18805653775, 18283.085845707927, 42366.57633423626, 42565.148697025266, 42928.0, 43106.78446607747, 43336.783316083216, 55243.44756552383, 56307.436925630216, 56724.14913776214, 57116.143257851996, 57406.425935741776, 11170.821689770743, 11447.427628618703, 12493.562725304571, 12558.560450384193, 12724.427400766803, 13367.732645346845, 13596.524121655695, 13674.179549227078, 13692.589222323346, 13783.794592865093, 10200.489975501047, 10391.168706503613, 10496.265261431627, 10628.734281642712, 11027.0, 10595.735106622396, 10607.469626518488, 10610.098141658045, 10724.571017159225, 10812.729681758019, 11168.832467513157, 11606.941965290458, 11634.767304653691, 11686.357250351311, 11725.589604363806, 11456.140789440658, 11547.595834145764, 11679.416029198335, 11848.0, 12158.331291779037, 11616.94191529037, 11726.237794543327, 11813.0, 11973.461194246454, 12127.090468214743], "value": 9332.042994909474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.4098553187234, 1269.5873841001676, 1286.215408600754, 1300.3693208793738, 1313.1792629606498, 9431.245500359972, 9751.70744877653, 9829.606815727371, 9888.505574721272, 10120.898791012087, 9877.604895804177, 10055.64805231817, 10066.949665251681, 10071.345362551447, 10081.798364032733, 2226.1651880544755, 2267.886605669718, 2271.613825649635, 2273.397549649336, 2273.8408311418207, 2102.9894850525725, 2190.59473997311, 2195.407240045187, 2197.7802219778055, 2198.1756841184556, 2110.556783075556, 2137.081055146294, 2154.924577639775, 2162.87022778633, 2174.7716489768504, 2135.1993002624017, 2142.9785702142935, 2150.290404166621, 2155.2133471282946, 2161.7838216178416, 1864.4127099963468, 1925.3550060729672, 2106.178590349765, 2112.8837913914726, 2158.3632828315685, 9745.463999480025, 9841.163501102343, 9847.359921605073, 9858.556364963593, 9875.753106172404, 5281.0, 5484.0, 5493.505584497414, 5498.505134537911, 5499.945000549983, 3275.574175357212, 3280.9835950820334, 3287.2603664175367, 3287.539744435781, 3329.9500507492407, 1056.4136904018267, 1080.0495563903794, 1093.5297821936565, 1099.9505022274018, 1116.3692513729716, 14275.999999999896, 14318.713625727427, 14329.140251584835, 14353.138811671333, 14417.783733243905, 4457.64338852891, 4714.481407045222, 4843.588294994965, 4845.75771211438, 4850.466448690711, 10595.629152979609, 10607.94696026515, 10615.416152111708, 10627.309224900511, 10644.520996555173, 5420.539254163361, 5434.782608695607, 5437.864053398696, 5439.619226654097, 5448.863778405572, 4639.164950308909, 4820.132376172252, 4939.0, 5000.849974500771, 5034.924476132861, 3723.1809002019513, 3782.1868298315444, 3786.6746638676796, 3873.24471728016, 3914.9021274467796, 1121.2599684208383, 1134.8865113488584, 1142.7200335917753, 1153.117864833403, 1160.0603511155991, 649.162580271454, 671.3756206727693, 676.7123972311846, 677.38019711963, 689.1385767790263, 5028.120078986236, 5034.823781167642, 5061.114304996611, 5083.389993200765, 5095.796168153306, 518.9844304670866, 524.1456426025554, 527.3144911614885, 527.3302905310235, 532.4010488200774, 2935.647722273341, 3308.4210263203845, 3421.367047096295, 3472.5312082868995, 3582.1044738815294, 12160.817587736192, 12816.55142070023, 12819.230846149261, 12821.0, 12826.294553799444, 12072.939635301944, 12623.87376126227, 12664.620061398173, 12665.683357916127, 12681.0, 9159.542022898962, 9368.4378937264, 9381.249500039981, 9401.670941517152, 9403.4828084456, 5640.464155905182, 5761.279840019997, 5903.0, 5946.762129514771, 6157.815265542041, 11066.114710822954, 11089.722756930818, 11382.487788049391, 11431.714207144556, 11513.0, 11345.773084538429, 11414.086873050303, 11537.307761534335, 11556.306621602731, 11627.941860290644, 7817.804554886174, 7936.761897143095, 7950.125486196398, 8001.319887809602, 8011.599420028859, 8955.238804701674, 9040.067111413135, 9115.27077833785, 9138.360314777901, 9267.351285409957, 7278.708851645875, 7347.669354878936, 7356.374708149867, 7370.410367170506, 7403.7408690695565, 7085.929140708733, 7154.2488038757265, 7163.641817909188, 7386.96306518464, 7415.3326200642205, 6616.735330586916, 6630.635315057718, 6679.799606011828, 6716.1604799400075, 6723.764668236784, 4884.242942343943, 4953.331300274417, 5035.219540971156, 5077.162268225701, 5247.55395791362, 4814.374131363041, 4823.5658790709, 4858.514148585114, 4973.502649734997, 5054.368203974504], "value": 4526.99899375141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5316335600362, 386.86073013715065, 392.0395032171181, 394.29224541947207, 398.5715355992309, 5489.258950041743, 5611.242482264898, 5659.179418984245, 5667.263255776743, 5670.688112153835, 5401.594880383977, 5469.234307196995, 5472.808451704191, 5492.450754924505, 5492.862678433041, 4257.701960862741, 4257.87226383209, 4267.082577245899, 4267.722598031133, 4268.530461649231, 4096.139810639769, 4245.23585754564, 4276.401303817468, 4278.9786051069705, 4312.719673221231, 4230.4500414946015, 4253.404523366731, 4253.65970722343, 4254.85119017865, 4258.616724494795, 4238.19474299882, 4255.893602659928, 4268.146370725867, 4276.42268293781, 4299.484061912559, 3529.2764983178386, 3746.2882052409955, 3751.8499260029566, 3757.8684746034032, 3761.5298087739034, 5397.54120899724, 5404.8108316208745, 5406.40529541754, 5412.323459567554, 5444.5916556258435, 4909.631777616657, 4915.557599815998, 4919.532644398776, 4923.901521969577, 4933.827316043921, 5547.306586676666, 5807.157962095473, 5881.323647780518, 5894.823155305347, 5895.380984996556, 4062.7765472898977, 4082.5713300103657, 4087.1825634873144, 4095.877123686294, 4100.938485922714, 6010.398960103998, 6145.877082458371, 6176.4132407421675, 6206.534509911775, 6248.250209974832, 4131.987663022519, 4133.689973252018, 4156.854510092193, 4158.334666453353, 4164.354525048622, 4229.175310814362, 4232.619064284229, 4240.38514415408, 4240.918565765772, 4247.129338485603, 4739.66822322441, 4834.806607735722, 4848.539388758062, 4854.17479028566, 4870.561649451566, 5783.248177736868, 5796.47831695141, 5796.536277097822, 5821.94178058214, 5826.708664566755, 1448.2830998655522, 1460.6713489464785, 1461.6857375664283, 1463.4585203474783, 1464.282501574221, 927.2195499262821, 968.4237878462303, 969.2391472693902, 972.7033254857337, 988.2439933450916, 5083.110455670243, 5111.718855462986, 5115.232715092766, 5116.386033675983, 5144.305518754995, 6080.361562036011, 6088.908666370008, 6105.572609917263, 6106.0, 6107.8473038173515, 4921.311016457699, 5050.368703912011, 5085.771140298695, 5105.897882042338, 5114.718690471986, 3181.602299712536, 3220.760007397169, 3224.2584205632834, 3228.693274139, 3236.8543415546355, 5533.501984821305, 5637.577181711388, 5651.491365777099, 5660.518855897212, 5679.926826708222, 6143.508519318444, 6203.7828675997025, 6221.377862213742, 6230.532710046765, 6267.780627678009, 5631.943680563142, 5652.7173641318595, 5652.745626446902, 5653.123765816305, 5666.9716651416475, 5912.408759124053, 5991.221141251609, 5995.700214989321, 6050.848728781815, 6106.1146133811235, 5931.3178984417345, 5957.195778569838, 5962.511930520694, 5981.3719559445635, 6000.21997140369, 5454.509094181384, 5624.35319938196, 5683.403242659627, 5686.34607020198, 5692.174634678031, 4153.397757325231, 4153.709240353146, 4176.164767046542, 4187.769672668032, 4189.07840275139, 5981.102834574848, 6084.209052823105, 6134.938650613437, 6139.048447490646, 6142.477889379453, 5824.5340372770925, 5887.764489420375, 5895.0, 5910.290765108214, 5920.0, 5874.559408044328, 5908.172855800278, 5909.674967876636, 5910.379410162043, 5913.201717768046, 5567.721613919207, 5795.652260864362, 5802.332731735904, 5827.4172582741385, 5834.591578589458, 5941.405859414024, 5956.791512297049, 5966.522678185648, 5974.133750606051, 5979.0, 5530.529904957963, 5685.687287199078, 5749.9712501437225, 5763.415060858129, 5778.104393818797], "value": 4392.386850793866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.0908637044433, 612.7334609444891, 615.8860610787004, 625.7590827531399, 639.2041907824758, 12393.504259829608, 12679.302638354899, 12737.363131843395, 12751.234925904453, 12860.742785144292, 13576.592702218924, 13613.795793063113, 13624.0, 13662.590122296348, 13764.449422023132, 877.118495911608, 893.5442924108719, 899.3614533681094, 903.7559858838109, 904.1139683110556, 911.4485736129645, 912.3659056955419, 912.7353067610385, 912.9954350228239, 923.1276443760648, 951.1724799424476, 951.2295041016798, 951.4719330771454, 955.8327292723781, 966.1884017425361, 934.9392289501161, 941.0683423410842, 944.2304521814733, 945.4799860076964, 948.4925564822821, 688.7658196213262, 693.3482526425145, 694.944404447643, 695.513140801436, 706.2795948132926, 13623.659408514768, 13865.722685546334, 14228.0, 14285.857141428556, 14311.0, 12873.356332183354, 13405.195688258638, 13517.526886558922, 13708.0, 13914.791278130837, 8802.735917922473, 8986.326025548111, 9060.184583387461, 9093.545322733837, 9258.213051890598, 2357.3870793593787, 2360.988195059031, 2367.869767162805, 2426.3206302235403, 2432.2946345559767, 56976.430235697524, 57642.423575764544, 58494.41505584932, 58673.53316167087, 59380.0, 9180.6786762463, 9188.95405522968, 9800.607975680892, 10136.797264054678, 10261.076503114606, 20630.27794027202, 21193.0, 21410.892945535485, 21427.250046248617, 21650.891745541172, 6229.127922090911, 6236.844078898064, 6336.429721325103, 6433.099366088752, 6591.6374599397495, 2818.675852277014, 2952.232419570884, 2980.3890202508433, 3001.384716133231, 3021.8640161192798, 3402.863885444604, 3457.239407330383, 3469.670381313771, 3480.7911525308564, 3482.930341393158, 658.2265837640753, 658.5719282466436, 660.0594153331483, 664.9335066493312, 681.6080753566719, 468.4261779320373, 469.4999825186166, 470.77402846633123, 482.75379556426475, 491.037566369919, 6638.535302528873, 6694.665266736741, 6901.0, 7015.0, 7037.894431583531, 475.1328824894581, 496.91055609989826, 502.8214983680814, 506.3695698854949, 513.9897202055938, 3375.6624337566536, 3393.5418718473184, 3423.5720534933134, 3480.4953281774, 3524.1189702574356, 65374.67312663501, 65392.67303663546, 65476.0, 65993.34006659871, 68479.65760171266, 57215.0, 57834.42165578374, 57884.0, 58663.70668146632, 58932.41067589355, 48490.272645910336, 49243.26135107976, 49338.0, 50249.74875125601, 50907.745461273196, 6681.732730690913, 8348.364853723591, 8366.790830229293, 8525.87211191845, 8639.611217495101, 25167.496650067264, 25260.242192734248, 25509.61735574005, 26332.736672633793, 26707.06525271606, 44051.0, 44265.557344426146, 46371.76814116043, 46413.535864642276, 46693.53306467028, 9824.950875245579, 9929.3545919515, 9986.0, 10002.199824014207, 10494.370337779757, 10500.264981451224, 10503.894961050291, 10570.471476425993, 10678.359298442118, 11130.666080017612, 10932.398718070583, 11160.10719142483, 11293.943530282297, 11703.356315402394, 11764.117691173367, 11244.498398853284, 11371.0, 11392.715182120513, 11474.403445814616, 11523.193376463567, 10166.542505587118, 10604.787904242026, 10618.52216650268, 10633.255672103189, 10958.068564172134, 7769.689212431439, 7853.293203611703, 8095.2714255717265, 8268.09051004401, 8540.14598540141, 8219.83560328802, 8232.300254478436, 8419.915800841913, 8452.915470845213, 8483.406161568631], "value": 6026.325026691863, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 113.0, 112.0, 113.0, 111.0, 111.0, 112.0, 111.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 125.0, 167.0, 124.0, 126.0, 126.0, 126.0, 155.0, 125.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 169.0, 172.0, 169.0, 168.0, 165.0, 165.0, 166.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 122.0, 76.0, 75.0, 79.0, 76.0, 93.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 85.0, 85.0, 84.0, 112.0, 85.0, 85.0, 108.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 122.0, 115.0, 115.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 152.0, 152.0, 152.0, 151.0, 158.0, 151.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 95.0, 95.0, 101.0, 95.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 71.0, 69.0, 70.0, 72.0, 70.0, 72.0, 69.0], "value": 69.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 85.0, 85.0, 90.0, 84.0, 83.0, 83.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 136.0, 153.0, 138.0, 135.0, 142.0, 142.0, 197.0, 139.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 197.0, 193.0, 200.0, 197.0, 197.0, 198.0, 197.0, 197.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 71.0, 72.0, 71.0, 70.0, 73.0, 71.0, 76.0], "value": 72.1, "unit": "score"}]}]} 04:50:10 INFO - Return code: 0 04:50:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:50:10 ERROR - # TBPL SUCCESS # 04:50:10 INFO - Running post-action listener: _resource_record_post_action 04:50:10 INFO - [mozharness: 2017-03-31 11:50:10.093559Z] Finished run-tests step (success) 04:50:10 INFO - Running post-run listener: _resource_record_post_run 04:50:10 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366940160; Read time: 12; Write time: 364320 04:50:10 INFO - TinderboxPrint: CPU usage
13.3% 04:50:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:50:10 INFO - TinderboxPrint: I/O write bytes / time
366,940,160 / 364,320 04:50:10 INFO - TinderboxPrint: CPU idle
8,311.4 (86.6%) 04:50:10 INFO - TinderboxPrint: CPU user
1,221.2 (12.7%) 04:50:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:50:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106598400; Read time: 0; Write time: 152372 04:50:10 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 260341760; Read time: 0; Write time: 211948 04:50:10 INFO - Running post-run listener: _upload_blobber_files 04:50:10 INFO - Blob upload gear active. 04:50:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:50:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:50:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:50:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:50:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:50:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:12 INFO - (blobuploader) - INFO - Done attempting. 04:50:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:50:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:50:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:15 INFO - (blobuploader) - INFO - Done attempting. 04:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:16 INFO - (blobuploader) - INFO - Done attempting. 04:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:17 INFO - (blobuploader) - INFO - Done attempting. 04:50:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:17 INFO - Return code: 0 04:50:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/408e13e9afd505cf1d9d3987266c4585bf98a4d2fd2755d073265f689033054350877694f5999e679683d73db962eac1b88e393d9cbab39c211aee79f138f8ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7042326c1cc8f45737096b4cd675d50f403d60687b45b57ef17c00696810a32733f22e517cee729e7e993a7fc7ca4d70b7b0356806c10b8e83ff8bc612d1f94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2fc65bbb6888ec3fdf1de6b915c678f5749bf61963e0cdfbae704c2cbb030fd69458837852e52f6eeea8d3bc75a4d2cb333e85fbae1fa9fbf31f15b824727b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/178ce7fd233eb86c6c9a04e5eba3262eb2f288de71001bf7521bd5b8889f384710847ac25c0c3785bc67688aaaaf079143b86fc9028a4436bb59dbc54a1e17a2"} 04:50:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:17 INFO - Contents: 04:50:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/408e13e9afd505cf1d9d3987266c4585bf98a4d2fd2755d073265f689033054350877694f5999e679683d73db962eac1b88e393d9cbab39c211aee79f138f8ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7042326c1cc8f45737096b4cd675d50f403d60687b45b57ef17c00696810a32733f22e517cee729e7e993a7fc7ca4d70b7b0356806c10b8e83ff8bc612d1f94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2fc65bbb6888ec3fdf1de6b915c678f5749bf61963e0cdfbae704c2cbb030fd69458837852e52f6eeea8d3bc75a4d2cb333e85fbae1fa9fbf31f15b824727b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/178ce7fd233eb86c6c9a04e5eba3262eb2f288de71001bf7521bd5b8889f384710847ac25c0c3785bc67688aaaaf079143b86fc9028a4436bb59dbc54a1e17a2"} 04:50:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:17 INFO - Copying logs to upload dir... 04:50:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.864538 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-31 04:50:16.182493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:16.186413) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 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/408e13e9afd505cf1d9d3987266c4585bf98a4d2fd2755d073265f689033054350877694f5999e679683d73db962eac1b88e393d9cbab39c211aee79f138f8ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7042326c1cc8f45737096b4cd675d50f403d60687b45b57ef17c00696810a32733f22e517cee729e7e993a7fc7ca4d70b7b0356806c10b8e83ff8bc612d1f94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2fc65bbb6888ec3fdf1de6b915c678f5749bf61963e0cdfbae704c2cbb030fd69458837852e52f6eeea8d3bc75a4d2cb333e85fbae1fa9fbf31f15b824727b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/178ce7fd233eb86c6c9a04e5eba3262eb2f288de71001bf7521bd5b8889f384710847ac25c0c3785bc67688aaaaf079143b86fc9028a4436bb59dbc54a1e17a2"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 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/408e13e9afd505cf1d9d3987266c4585bf98a4d2fd2755d073265f689033054350877694f5999e679683d73db962eac1b88e393d9cbab39c211aee79f138f8ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7042326c1cc8f45737096b4cd675d50f403d60687b45b57ef17c00696810a32733f22e517cee729e7e993a7fc7ca4d70b7b0356806c10b8e83ff8bc612d1f94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2fc65bbb6888ec3fdf1de6b915c678f5749bf61963e0cdfbae704c2cbb030fd69458837852e52f6eeea8d3bc75a4d2cb333e85fbae1fa9fbf31f15b824727b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/178ce7fd233eb86c6c9a04e5eba3262eb2f288de71001bf7521bd5b8889f384710847ac25c0c3785bc67688aaaaf079143b86fc9028a4436bb59dbc54a1e17a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:16.211966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:16.212280) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1490959755.618436-812139454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:50:16.297200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:16.297624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:50:16.297964) ========= ========= Total master_lag: 0.15 =========