builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1486172167.16 results: success (0) revision: 09b28b955a478f5a63b96db165a7974b367e14c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.156363) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.156854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.157225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.174092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.174408) ========= 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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 17:36:07-- 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% 66.1K=0.2s 2017-02-03 17:36:07 (66.1 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.338813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.526764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.527084) ========= 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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018817 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:07.576398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 17:36:07.576741) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 09b28b955a478f5a63b96db165a7974b367e14c3 --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 09b28b955a478f5a63b96db165a7974b367e14c3 --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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 17:36:07,709 truncating revision to first 12 chars 2017-02-03 17:36:07,709 Setting DEBUG logging. 2017-02-03 17:36:07,709 attempt 1/10 2017-02-03 17:36:07,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/09b28b955a47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 17:36:09,120 unpacking tar archive at: mozilla-central-09b28b955a47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.725060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 17:36:09.314737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:09.315082) ========= script_repo_revision: 09b28b955a478f5a63b96db165a7974b367e14c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:09.315473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:09.315766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 17:36:09.324117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-02-03 17:36:09.324387) ========= /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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:09 INFO - MultiFileLogger online at 20170203 17:36:09 in /builds/slave/test 17:36:09 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 17:36:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:09 INFO - {'append_to_log': False, 17:36:09 INFO - 'base_work_dir': '/builds/slave/test', 17:36:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:36:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:09 INFO - 'branch': 'Firefox-Non-PGO', 17:36:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:09 INFO - 'config_files': ('talos/linux_config.py',), 17:36:09 INFO - 'default_actions': ('clobber', 17:36:09 INFO - 'read-buildbot-config', 17:36:09 INFO - 'download-and-extract', 17:36:09 INFO - 'populate-webroot', 17:36:09 INFO - 'create-virtualenv', 17:36:09 INFO - 'install', 17:36:09 INFO - 'run-tests'), 17:36:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:09 INFO - 'download_minidump_stackwalk': True, 17:36:09 INFO - 'download_symbols': 'ondemand', 17:36:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:09 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:09 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:09 INFO - 'installer_path': 'installer.exe', 17:36:09 INFO - 'log_level': 'info', 17:36:09 INFO - 'log_name': 'talos', 17:36:09 INFO - 'log_to_console': True, 17:36:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:09 INFO - 'opt_config_files': (), 17:36:09 INFO - 'pip_index': False, 17:36:09 INFO - 'sps_profile': False, 17:36:09 INFO - 'sps_profile_interval': 0, 17:36:09 INFO - 'suite': 'dromaeojs-e10s', 17:36:09 INFO - 'system_bits': '32', 17:36:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:09 INFO - 'title': 'talos-linux64-ix-018', 17:36:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:09 INFO - 'use_talos_json': True, 17:36:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:09 INFO - 'work_dir': 'build'} 17:36:09 INFO - [mozharness: 2017-02-04 01:36:09.560177Z] Running clobber step. 17:36:09 INFO - Running pre-action listener: _resource_record_pre_action 17:36:09 INFO - Running main action method: clobber 17:36:09 INFO - rmtree: /builds/slave/test/build 17:36:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:10 INFO - Running post-action listener: _resource_record_post_action 17:36:10 INFO - [mozharness: 2017-02-04 01:36:10.042137Z] Finished clobber step (success) 17:36:10 INFO - [mozharness: 2017-02-04 01:36:10.042237Z] Running read-buildbot-config step. 17:36:10 INFO - Running pre-action listener: _resource_record_pre_action 17:36:10 INFO - Running main action method: read_buildbot_config 17:36:10 INFO - Using buildbot properties: 17:36:10 INFO - { 17:36:10 INFO - "project": "", 17:36:10 INFO - "product": "firefox", 17:36:10 INFO - "who": "kwierso@gmail.com", 17:36:10 INFO - "installer_path": "public/build/target.tar.bz2", 17:36:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:36:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:36:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:36:10 INFO - "stage_platform": "linux64", 17:36:10 INFO - "basedir": "/builds/slave/test", 17:36:10 INFO - "buildnumber": 651, 17:36:10 INFO - "platform": "ubuntu64_hw", 17:36:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:36:10 INFO - "slavebuilddir": "test", 17:36:10 INFO - "taskId": "R6YqPSR8SlumQjWPbNClRw", 17:36:10 INFO - "branch": "mozilla-central", 17:36:10 INFO - "script_repo_revision": "production", 17:36:10 INFO - "revision": "09b28b955a478f5a63b96db165a7974b367e14c3", 17:36:10 INFO - "slavename": "talos-linux64-ix-018", 17:36:10 INFO - "repo_path": "mozilla-central" 17:36:10 INFO - } 17:36:10 INFO - Finding installer, test and symbols from parent task. 17:36:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6YqPSR8SlumQjWPbNClRw'}, attempt #1 17:36:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6YqPSR8SlumQjWPbNClRw'}, attempt #1 17:36:10 INFO - Task dependencies: WxR2bgBpRfybZxMw7l3iyg 17:36:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg'}, attempt #1 17:36:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 17:36:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/test_packages.json 17:36:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.crashreporter-symbols.zip 17:36:11 INFO - Running post-action listener: _resource_record_post_action 17:36:11 INFO - [mozharness: 2017-02-04 01:36:11.406700Z] Finished read-buildbot-config step (success) 17:36:11 INFO - [mozharness: 2017-02-04 01:36:11.406916Z] Running download-and-extract step. 17:36:11 INFO - Running pre-action listener: _resource_record_pre_action 17:36:11 INFO - Running main action method: download_and_extract 17:36:11 INFO - mkdir: /builds/slave/test/build/tests 17:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:11 INFO - trying https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.test_packages.json 17:36:11 INFO - Downloading https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:36:11 INFO - Downloaded 896 bytes. 17:36:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:36:11 INFO - Using the following test package requirements: 17:36:11 INFO - {u'common': [u'target.common.tests.zip'], 17:36:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:36:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:36:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:36:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:36:11 INFO - u'mozbase': [u'target.common.tests.zip'], 17:36:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:36:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:36:11 INFO - u'web-platform': [u'target.common.tests.zip', 17:36:11 INFO - u'target.web-platform.tests.zip'], 17:36:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:36:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip 17:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip into memory 17:36:12 INFO - Expected file size: 39902192 17:36:12 INFO - Obtained file size: 39902192 17:36:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:36:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip 17:36:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:36:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.common.tests.zip into memory 17:36:18 INFO - Expected file size: 39902192 17:36:18 INFO - Obtained file size: 39902192 17:36:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.talos.tests.zip 17:36:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:36:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.talos.tests.zip into memory 17:36:23 INFO - Expected file size: 14403454 17:36:23 INFO - Obtained file size: 14403454 17:36: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')]} 17:36:23 INFO - trying https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 17:36:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:36:24 INFO - Downloaded 56333095 bytes. 17:36:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 17:36:24 INFO - mkdir: /builds/slave/test/properties 17:36:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:24 INFO - Contents: 17:36:24 INFO - build_url:https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 17:36:24 INFO - Running post-action listener: _resource_record_post_action 17:36:24 INFO - Running post-action listener: set_extra_try_arguments 17:36:24 INFO - [mozharness: 2017-02-04 01:36:24.968170Z] Finished download-and-extract step (success) 17:36:24 INFO - [mozharness: 2017-02-04 01:36:24.968267Z] Running populate-webroot step. 17:36:24 INFO - Running pre-action listener: _resource_record_pre_action 17:36:24 INFO - Running main action method: populate_webroot 17:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:24 INFO - '--tppagecycles', 17:36:24 INFO - '7'], 17:36:24 INFO - 'tests': ['tsvgm']}}, 17:36:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['damp', 'tps']}, 17:36:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'tests': ['damp', 'tps']}, 17:36:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['dromaeo_dom']}, 17:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['basic_compositor_video']}, 17:36:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['a11yr', 17:36:24 INFO - 'ts_paint', 17:36:24 INFO - 'tpaint', 17:36:24 INFO - 'sessionrestore', 17:36:24 INFO - 'sessionrestore_no_auto_restore', 17:36:24 INFO - 'tabpaint']}, 17:36:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['tsvgx', 17:36:24 INFO - 'tsvgr_opacity', 17:36:24 INFO - 'tart', 17:36:24 INFO - 'tscrollx', 17:36:24 INFO - 'cart', 17:36:24 INFO - 'tsvg_static']}, 17:36:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:24 INFO - 'tsvgr_opacity', 17:36:24 INFO - 'tart', 17:36:24 INFO - 'tscrollx', 17:36:24 INFO - 'cart', 17:36:24 INFO - 'tsvg_static']}, 17:36:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'talos_options': ['--disable-e10s'], 17:36:24 INFO - 'tests': ['tp5o']}, 17:36:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:36:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'talos_options': ['--disable-e10s', 17:36:24 INFO - '--xperf_path', 17:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:24 INFO - 'tests': ['tp5n']}, 17:36:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:36:24 INFO - 'talos_options': ['--xperf_path', 17:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:24 INFO - 'tests': ['tp5n']}}, 17:36:24 INFO - 'talos.zip': {'path': '', 17:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:24 INFO - Running post-action listener: _resource_record_post_action 17:36:24 INFO - [mozharness: 2017-02-04 01:36:24.981373Z] Finished populate-webroot step (success) 17:36:24 INFO - [mozharness: 2017-02-04 01:36:24.981474Z] Running create-virtualenv step. 17:36:24 INFO - Running pre-action listener: _resource_record_pre_action 17:36:24 INFO - Running main action method: create_virtualenv 17:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:25 INFO - Using real prefix '/usr' 17:36:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:27 INFO - Installing pip.................done. 17:36:27 INFO - Return code: 0 17:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:36:27 INFO - Reading from file tmpfile_stdout 17:36:27 INFO - Output received: 17:36:27 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) 17:36:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:36:27 INFO - Using env: {'DISPLAY': ':0', 17:36:27 INFO - 'HOME': '/home/cltbld', 17:36:27 INFO - 'LANG': 'en_US.UTF-8', 17:36:27 INFO - 'LANGUAGE': 'en_US:en', 17:36:27 INFO - 'LOGNAME': 'cltbld', 17:36:27 INFO - 'MAIL': '/var/mail/cltbld', 17:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:27 INFO - 'MOZ_NO_REMOTE': '1', 17:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:27 INFO - 'NO_EM_RESTART': '1', 17:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:27 INFO - 'PWD': '/builds/slave/test', 17:36:27 INFO - 'SHELL': '/bin/bash', 17:36:27 INFO - 'SHLVL': '1', 17:36:27 INFO - 'TERM': 'linux', 17:36:27 INFO - 'TMOUT': '86400', 17:36:27 INFO - 'USER': 'cltbld', 17:36:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:27 INFO - '_': '/tools/buildbot/bin/python'} 17:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:36:27 INFO - Cleaning up... 17:36:27 INFO - Return code: 0 17:36:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:36:27 INFO - Using env: {'DISPLAY': ':0', 17:36:27 INFO - 'HOME': '/home/cltbld', 17:36:27 INFO - 'LANG': 'en_US.UTF-8', 17:36:27 INFO - 'LANGUAGE': 'en_US:en', 17:36:27 INFO - 'LOGNAME': 'cltbld', 17:36:27 INFO - 'MAIL': '/var/mail/cltbld', 17:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:27 INFO - 'MOZ_NO_REMOTE': '1', 17:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:27 INFO - 'NO_EM_RESTART': '1', 17:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:27 INFO - 'PWD': '/builds/slave/test', 17:36:27 INFO - 'SHELL': '/bin/bash', 17:36:27 INFO - 'SHLVL': '1', 17:36:27 INFO - 'TERM': 'linux', 17:36:27 INFO - 'TMOUT': '86400', 17:36:27 INFO - 'USER': 'cltbld', 17:36:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:27 INFO - '_': '/tools/buildbot/bin/python'} 17:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:28 INFO - Downloading/unpacking psutil>=3.1.1 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:28 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 17:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:30 INFO - Installing collected packages: psutil 17:36:30 INFO - Running setup.py install for psutil 17:36:30 INFO - building 'psutil._psutil_linux' extension 17:36:30 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 17:36:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:36:30 INFO - building 'psutil._psutil_posix' extension 17:36:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:36:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:36:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:30 INFO - Successfully installed psutil 17:36:30 INFO - Cleaning up... 17:36:30 INFO - Return code: 0 17:36:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:36:30 INFO - Using env: {'DISPLAY': ':0', 17:36:30 INFO - 'HOME': '/home/cltbld', 17:36:30 INFO - 'LANG': 'en_US.UTF-8', 17:36:30 INFO - 'LANGUAGE': 'en_US:en', 17:36:30 INFO - 'LOGNAME': 'cltbld', 17:36:30 INFO - 'MAIL': '/var/mail/cltbld', 17:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:30 INFO - 'MOZ_NO_REMOTE': '1', 17:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:30 INFO - 'NO_EM_RESTART': '1', 17:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:30 INFO - 'PWD': '/builds/slave/test', 17:36:30 INFO - 'SHELL': '/bin/bash', 17:36:30 INFO - 'SHLVL': '1', 17:36:30 INFO - 'TERM': 'linux', 17:36:30 INFO - 'TMOUT': '86400', 17:36:30 INFO - 'USER': 'cltbld', 17:36:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:30 INFO - '_': '/tools/buildbot/bin/python'} 17:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:31 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 17:36:31 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 17:36:31 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 17:36:31 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 17:36:31 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 17:36:31 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 17:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:33 INFO - Installing collected packages: mozsystemmonitor 17:36:33 INFO - Running setup.py install for mozsystemmonitor 17:36:33 INFO - Successfully installed mozsystemmonitor 17:36:33 INFO - Cleaning up... 17:36:33 INFO - Return code: 0 17:36:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:33 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')]} 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:33 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')]} 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:33 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 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:33 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 17:36:33 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 17:36:33 INFO - Using env: {'DISPLAY': ':0', 17:36:33 INFO - 'HOME': '/home/cltbld', 17:36:33 INFO - 'LANG': 'en_US.UTF-8', 17:36:33 INFO - 'LANGUAGE': 'en_US:en', 17:36:33 INFO - 'LOGNAME': 'cltbld', 17:36:33 INFO - 'MAIL': '/var/mail/cltbld', 17:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:33 INFO - 'MOZ_NO_REMOTE': '1', 17:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:33 INFO - 'NO_EM_RESTART': '1', 17:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:33 INFO - 'PWD': '/builds/slave/test', 17:36:33 INFO - 'SHELL': '/bin/bash', 17:36:33 INFO - 'SHLVL': '1', 17:36:33 INFO - 'TERM': 'linux', 17:36:33 INFO - 'TMOUT': '86400', 17:36:33 INFO - 'USER': 'cltbld', 17:36:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:33 INFO - '_': '/tools/buildbot/bin/python'} 17:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:33 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:35 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:35 INFO - warning: no files found matching '*.txt' 17:36:35 INFO - no previously-included directories found matching 'build' 17:36:35 INFO - no previously-included directories found matching 'dist' 17:36:35 INFO - no previously-included directories found matching '.git*' 17:36:35 INFO - Installing collected packages: jsonschema, functools32 17:36:35 INFO - Running setup.py install for functools32 17:36:35 INFO - warning: no files found matching '*.txt' 17:36:35 INFO - no previously-included directories found matching 'build' 17:36:35 INFO - no previously-included directories found matching 'dist' 17:36:35 INFO - no previously-included directories found matching '.git*' 17:36:35 INFO - Successfully installed jsonschema functools32 17:36:35 INFO - Cleaning up... 17:36:35 INFO - Return code: 0 17:36:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:36:35 INFO - Using env: {'DISPLAY': ':0', 17:36:35 INFO - 'HOME': '/home/cltbld', 17:36:35 INFO - 'LANG': 'en_US.UTF-8', 17:36:35 INFO - 'LANGUAGE': 'en_US:en', 17:36:35 INFO - 'LOGNAME': 'cltbld', 17:36:35 INFO - 'MAIL': '/var/mail/cltbld', 17:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:35 INFO - 'MOZ_NO_REMOTE': '1', 17:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:35 INFO - 'NO_EM_RESTART': '1', 17:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:35 INFO - 'PWD': '/builds/slave/test', 17:36:35 INFO - 'SHELL': '/bin/bash', 17:36:35 INFO - 'SHLVL': '1', 17:36:35 INFO - 'TERM': 'linux', 17:36:35 INFO - 'TMOUT': '86400', 17:36:35 INFO - 'USER': 'cltbld', 17:36:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:35 INFO - '_': '/tools/buildbot/bin/python'} 17:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:36:36 INFO - Cleaning up... 17:36:36 INFO - Return code: 0 17:36:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:36 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')]} 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:36 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')]} 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:36 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 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:36 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 17:36:36 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 17:36:36 INFO - Using env: {'DISPLAY': ':0', 17:36:36 INFO - 'HOME': '/home/cltbld', 17:36:36 INFO - 'LANG': 'en_US.UTF-8', 17:36:36 INFO - 'LANGUAGE': 'en_US:en', 17:36:36 INFO - 'LOGNAME': 'cltbld', 17:36:36 INFO - 'MAIL': '/var/mail/cltbld', 17:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:36 INFO - 'MOZ_NO_REMOTE': '1', 17:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:36 INFO - 'NO_EM_RESTART': '1', 17:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:36 INFO - 'PWD': '/builds/slave/test', 17:36:36 INFO - 'SHELL': '/bin/bash', 17:36:36 INFO - 'SHLVL': '1', 17:36:36 INFO - 'TERM': 'linux', 17:36:36 INFO - 'TMOUT': '86400', 17:36:36 INFO - 'USER': 'cltbld', 17:36:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:36 INFO - '_': '/tools/buildbot/bin/python'} 17:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:39 INFO - Downloading docopt-0.6.1.tar.gz 17:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:39 INFO - Running setup.py install for blobuploader 17:36:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:39 INFO - Running setup.py install for requests 17:36:39 INFO - Running setup.py install for docopt 17:36:39 INFO - Successfully installed blobuploader requests docopt 17:36:39 INFO - Cleaning up... 17:36:39 INFO - Return code: 0 17:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:39 INFO - Using env: {'DISPLAY': ':0', 17:36:39 INFO - 'HOME': '/home/cltbld', 17:36:39 INFO - 'LANG': 'en_US.UTF-8', 17:36:39 INFO - 'LANGUAGE': 'en_US:en', 17:36:39 INFO - 'LOGNAME': 'cltbld', 17:36:39 INFO - 'MAIL': '/var/mail/cltbld', 17:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:39 INFO - 'MOZ_NO_REMOTE': '1', 17:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:39 INFO - 'NO_EM_RESTART': '1', 17:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:39 INFO - 'PWD': '/builds/slave/test', 17:36:39 INFO - 'SHELL': '/bin/bash', 17:36:39 INFO - 'SHLVL': '1', 17:36:39 INFO - 'TERM': 'linux', 17:36:39 INFO - 'TMOUT': '86400', 17:36:39 INFO - 'USER': 'cltbld', 17:36:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:39 INFO - '_': '/tools/buildbot/bin/python'} 17:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:40 INFO - Running setup.py (path:/tmp/pip-IMCRHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:40 INFO - Running setup.py (path:/tmp/pip-8Nk_o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:40 INFO - Running setup.py (path:/tmp/pip-XBnQz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:40 INFO - Running setup.py (path:/tmp/pip-gDjklf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:40 INFO - Running setup.py (path:/tmp/pip-I_pVve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:40 INFO - Running setup.py (path:/tmp/pip-_SFu8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:40 INFO - Running setup.py (path:/tmp/pip-mOmyEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:40 INFO - Running setup.py (path:/tmp/pip-B_S2cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:40 INFO - Running setup.py (path:/tmp/pip-b1n_74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:40 INFO - Running setup.py (path:/tmp/pip-Cr10UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:40 INFO - Running setup.py (path:/tmp/pip-206RHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:40 INFO - Running setup.py (path:/tmp/pip-9dHt3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:40 INFO - Running setup.py (path:/tmp/pip-0BvNp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:40 INFO - Running setup.py (path:/tmp/pip-CxqExb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:41 INFO - Running setup.py (path:/tmp/pip-bAHOqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:41 INFO - Running setup.py (path:/tmp/pip-tSfyaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:41 INFO - Running setup.py (path:/tmp/pip-4IuBkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:41 INFO - Running setup.py install for manifestparser 17:36:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozcrash 17:36:41 INFO - Running setup.py install for mozdebug 17:36:41 INFO - Running setup.py install for mozdevice 17:36:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozfile 17:36:41 INFO - Running setup.py install for mozhttpd 17:36:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozinfo 17:36:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozInstall 17:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Running setup.py install for mozleak 17:36:42 INFO - Running setup.py install for mozlog 17:36:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Running setup.py install for moznetwork 17:36:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Running setup.py install for mozprocess 17:36:42 INFO - Running setup.py install for mozprofile 17:36:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Running setup.py install for mozrunner 17:36:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:42 INFO - Running setup.py install for mozscreenshot 17:36:42 INFO - Running setup.py install for moztest 17:36:42 INFO - Running setup.py install for mozversion 17:36:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:43 INFO - Cleaning up... 17:36:43 INFO - Return code: 0 17:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:43 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 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:43 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 17:36:43 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 17:36:43 INFO - Using env: {'DISPLAY': ':0', 17:36:43 INFO - 'HOME': '/home/cltbld', 17:36:43 INFO - 'LANG': 'en_US.UTF-8', 17:36:43 INFO - 'LANGUAGE': 'en_US:en', 17:36:43 INFO - 'LOGNAME': 'cltbld', 17:36:43 INFO - 'MAIL': '/var/mail/cltbld', 17:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:43 INFO - 'MOZ_NO_REMOTE': '1', 17:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:43 INFO - 'NO_EM_RESTART': '1', 17:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:43 INFO - 'PWD': '/builds/slave/test', 17:36:43 INFO - 'SHELL': '/bin/bash', 17:36:43 INFO - 'SHLVL': '1', 17:36:43 INFO - 'TERM': 'linux', 17:36:43 INFO - 'TMOUT': '86400', 17:36:43 INFO - 'USER': 'cltbld', 17:36:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:43 INFO - '_': '/tools/buildbot/bin/python'} 17:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:43 INFO - Running setup.py (path:/tmp/pip-rwOleX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:43 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)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:43 INFO - Running setup.py (path:/tmp/pip-XI7X4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:43 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)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:43 INFO - Running setup.py (path:/tmp/pip-mtdEIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:43 INFO - Running setup.py (path:/tmp/pip-IPyw7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:43 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)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:43 INFO - Running setup.py (path:/tmp/pip-kpmuRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:43 INFO - Running setup.py (path:/tmp/pip-ekuDDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:43 INFO - Running setup.py (path:/tmp/pip-htRztE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:43 INFO - Running setup.py (path:/tmp/pip-_LTG5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:43 INFO - Running setup.py (path:/tmp/pip-81QDFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:43 INFO - Running setup.py (path:/tmp/pip-gmZAb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:43 INFO - Running setup.py (path:/tmp/pip-vxU1Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:44 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:44 INFO - Running setup.py (path:/tmp/pip-JEITiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:44 INFO - Running setup.py (path:/tmp/pip-m6krXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:44 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:44 INFO - Running setup.py (path:/tmp/pip-qYkKVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:44 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:44 INFO - Running setup.py (path:/tmp/pip-S8tJQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:44 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:44 INFO - Running setup.py (path:/tmp/pip-tZMgwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:44 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)) 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:44 INFO - Running setup.py (path:/tmp/pip-Q_Fa1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:46 INFO - Downloading blessings-1.6.tar.gz 17:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:46 INFO - Installing collected packages: blessings 17:36:46 INFO - Running setup.py install for blessings 17:36:46 INFO - Successfully installed blessings 17:36:46 INFO - Cleaning up... 17:36:46 INFO - Return code: 0 17:36:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:46 INFO - Reading from file tmpfile_stdout 17:36:46 INFO - Current package versions: 17:36:46 INFO - argparse == 1.2.1 17:36:46 INFO - blessings == 1.6 17:36:46 INFO - blobuploader == 1.2.4 17:36:46 INFO - docopt == 0.6.1 17:36:46 INFO - functools32 == 3.2.3-2 17:36:46 INFO - jsonschema == 2.5.1 17:36:46 INFO - manifestparser == 1.1 17:36:46 INFO - mozInstall == 1.12 17:36:46 INFO - mozcrash == 1.0 17:36:46 INFO - mozdebug == 0.1 17:36:46 INFO - mozdevice == 0.49 17:36:46 INFO - mozfile == 1.2 17:36:46 INFO - mozhttpd == 0.7 17:36:46 INFO - mozinfo == 0.9 17:36:46 INFO - mozleak == 0.1 17:36:46 INFO - mozlog == 3.4 17:36:46 INFO - moznetwork == 0.27 17:36:46 INFO - mozprocess == 0.24 17:36:46 INFO - mozprofile == 0.28 17:36:46 INFO - mozrunner == 6.13 17:36:46 INFO - mozscreenshot == 0.1 17:36:46 INFO - mozsystemmonitor == 0.3 17:36:46 INFO - moztest == 0.8 17:36:46 INFO - mozversion == 1.4 17:36:46 INFO - psutil == 3.1.1 17:36:46 INFO - requests == 1.2.3 17:36:46 INFO - wsgiref == 0.1.2 17:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:46 INFO - Using env: {'DISPLAY': ':0', 17:36:46 INFO - 'HOME': '/home/cltbld', 17:36:46 INFO - 'LANG': 'en_US.UTF-8', 17:36:46 INFO - 'LANGUAGE': 'en_US:en', 17:36:46 INFO - 'LOGNAME': 'cltbld', 17:36:46 INFO - 'MAIL': '/var/mail/cltbld', 17:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:46 INFO - 'MOZ_NO_REMOTE': '1', 17:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:46 INFO - 'NO_EM_RESTART': '1', 17:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:46 INFO - 'PWD': '/builds/slave/test', 17:36:46 INFO - 'SHELL': '/bin/bash', 17:36:46 INFO - 'SHLVL': '1', 17:36:46 INFO - 'TERM': 'linux', 17:36:46 INFO - 'TMOUT': '86400', 17:36:46 INFO - 'USER': 'cltbld', 17:36:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:46 INFO - '_': '/tools/buildbot/bin/python'} 17:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 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)) 17:36:47 INFO - Cleaning up... 17:36:47 INFO - Return code: 0 17:36:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2751a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, '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': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', '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 17:36: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', 'jsonschema'] in /builds/slave/test/build 17:36: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 jsonschema 17:36:47 INFO - Using env: {'DISPLAY': ':0', 17:36:47 INFO - 'HOME': '/home/cltbld', 17:36:47 INFO - 'LANG': 'en_US.UTF-8', 17:36:47 INFO - 'LANGUAGE': 'en_US:en', 17:36:47 INFO - 'LOGNAME': 'cltbld', 17:36:47 INFO - 'MAIL': '/var/mail/cltbld', 17:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:47 INFO - 'MOZ_NO_REMOTE': '1', 17:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:47 INFO - 'NO_EM_RESTART': '1', 17:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:47 INFO - 'PWD': '/builds/slave/test', 17:36:47 INFO - 'SHELL': '/bin/bash', 17:36:47 INFO - 'SHLVL': '1', 17:36:47 INFO - 'TERM': 'linux', 17:36:47 INFO - 'TMOUT': '86400', 17:36:47 INFO - 'USER': 'cltbld', 17:36:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:47 INFO - '_': '/tools/buildbot/bin/python'} 17:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:36:47 INFO - Cleaning up... 17:36:47 INFO - Return code: 0 17:36:47 INFO - Running post-action listener: _resource_record_post_action 17:36:47 INFO - Running post-action listener: _start_resource_monitoring 17:36:47 INFO - Starting resource monitoring. 17:36:47 INFO - [mozharness: 2017-02-04 01:36:47.484811Z] Finished create-virtualenv step (success) 17:36:47 INFO - [mozharness: 2017-02-04 01:36:47.485256Z] Running install step. 17:36:47 INFO - Running pre-action listener: _resource_record_pre_action 17:36:47 INFO - Running main action method: install 17:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:47 INFO - Reading from file tmpfile_stdout 17:36:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:47 INFO - Reading from file tmpfile_stdout 17:36:47 INFO - Output received: 17:36:47 INFO - Usage: mozinstall [options] installer 17:36:47 INFO - Options: 17:36:47 INFO - -h, --help show this help message and exit 17:36:47 INFO - -d DEST, --destination=DEST 17:36:47 INFO - Directory to install application into. [default: 17:36:47 INFO - "/builds/slave/test"] 17:36:47 INFO - --app=APP Application being installed. [default: firefox] 17:36:47 INFO - mkdir: /builds/slave/test/build/application 17:36:47 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'] 17:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:37:03 INFO - Reading from file tmpfile_stdout 17:37:03 INFO - Output received: 17:37:03 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:03 INFO - Running post-action listener: _resource_record_post_action 17:37:03 INFO - [mozharness: 2017-02-04 01:37:03.998588Z] Finished install step (success) 17:37:03 INFO - [mozharness: 2017-02-04 01:37:03.998866Z] Running run-tests step. 17:37:03 INFO - Running pre-action listener: _resource_record_pre_action 17:37:03 INFO - Running main action method: run_tests 17:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:04 INFO - Python 2.7.3 17:37:04 INFO - Return code: 0 17:37:04 INFO - grabbing minidump binary from tooltool 17:37:04 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')]} 17:37:04 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 0x29af820>, '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 0x29b0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b09b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:04 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 17:37:04 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 17:37:04 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 17:37:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:04 INFO - Return code: 0 17:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:04 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/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:37:04 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/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 17:37:04 INFO - Using env: {'DISPLAY': ':0', 17:37:04 INFO - 'HOME': '/home/cltbld', 17:37:04 INFO - 'LANG': 'en_US.UTF-8', 17:37:04 INFO - 'LANGUAGE': 'en_US:en', 17:37:04 INFO - 'LOGNAME': 'cltbld', 17:37:04 INFO - 'MAIL': '/var/mail/cltbld', 17:37:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:04 INFO - 'MOZ_NO_REMOTE': '1', 17:37:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:04 INFO - 'NO_EM_RESTART': '1', 17:37:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:04 INFO - 'PWD': '/builds/slave/test', 17:37:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:04 INFO - 'SHELL': '/bin/bash', 17:37:04 INFO - 'SHLVL': '1', 17:37:04 INFO - 'TERM': 'linux', 17:37:04 INFO - 'TMOUT': '86400', 17:37:04 INFO - 'USER': 'cltbld', 17:37:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849', 17:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:04 INFO - '_': '/tools/buildbot/bin/python'} 17:37:04 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/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 17:37:04 INFO - mozversion application_buildid: 20170204010428 17:37:04 INFO - mozversion application_changeset: 09b28b955a478f5a63b96db165a7974b367e14c3 17:37:04 INFO - mozversion application_display_name: Nightly 17:37:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:04 INFO - mozversion application_name: Firefox 17:37:04 INFO - mozversion application_remotingname: firefox 17:37:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:37:04 INFO - mozversion application_vendor: Mozilla 17:37:04 INFO - mozversion application_version: 54.0a1 17:37:04 INFO - mozversion platform_buildid: 20170204010428 17:37:04 INFO - mozversion platform_changeset: 09b28b955a478f5a63b96db165a7974b367e14c3 17:37:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:37:04 INFO - mozversion platform_version: 54.0a1 17:37:04 INFO - using testdate: 1486172224 17:37:04 INFO - actual date: 1486172224 17:37:04 INFO - starting webserver on 'localhost:59619' 17:37:04 INFO - SUITE-START | Running 2 tests 17:37:04 INFO - TEST-START | dromaeo_css 17:37:04 INFO - operating with platform_type : linux_ 17:37:04 INFO - Initialising browser for dromaeo_css test... 17:37:04 INFO - TEST-INFO | started process 7037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOV8Oi/profile http://localhost:59619/getInfo.html) 17:37:08 INFO - PROCESS | 7037 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:37:08 INFO - PROCESS | 7037 | __metrics Screen width/height:1600/1200 17:37:08 INFO - PROCESS | 7037 | colorDepth:24 17:37:08 INFO - PROCESS | 7037 | Browser inner width/height: 1024/697 17:37:08 INFO - PROCESS | 7037 | __metrics 17:37:08 INFO - PROCESS | 7037 | 1486172228911 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpOOV8Oi/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpOOV8Oi/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpOOV8Oi/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpOOV8Oi/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:37:08 ERROR - PROCESS | 7037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:37:09 INFO - TEST-INFO | 7037: exit 0 17:37:09 INFO - Browser initialized. 17:37:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:09 INFO - TEST-INFO | started process 7156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOV8Oi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:22 INFO - PROCESS | 7156 | RSS: Main: 162295808 17:37:22 INFO - PROCESS | 7156 | 17:40:26 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59619/tests/dromaeo/cssquery-ext.html) 17:40:28 INFO - PROCESS | 7156 | RSS: Main: 169857024 17:40:28 INFO - PROCESS | 7156 | 17:42:10 INFO - PROCESS | 7156 | ************************* 17:42:10 INFO - PROCESS | 7156 | A coding exception was thrown and uncaught in a Task. 17:42:10 INFO - PROCESS | 7156 | 17:42:10 ERROR - PROCESS | 7156 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:42:10 INFO - PROCESS | 7156 | Full stack: 17:42:10 INFO - PROCESS | 7156 | ************************* 17:43:30 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-ext.html (next: http://localhost:59619/tests/dromaeo/cssquery-jquery.html) 17:43:31 INFO - PROCESS | 7156 | RSS: Main: 164048896 17:43:31 INFO - PROCESS | 7156 | 17:46:33 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59619/tests/dromaeo/cssquery-mootools.html) 17:46:34 INFO - PROCESS | 7156 | RSS: Main: 171708416 17:46:34 INFO - PROCESS | 7156 | 17:49:36 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59619/tests/dromaeo/cssquery-prototype.html) 17:49:37 INFO - PROCESS | 7156 | RSS: Main: 164368384 17:49:37 INFO - PROCESS | 7156 | 17:52:40 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59619/tests/dromaeo/cssquery-yui.html) 17:52:40 INFO - PROCESS | 7156 | RSS: Main: 168046592 17:52:40 INFO - PROCESS | 7156 | 17:55:43 INFO - PROCESS | 7156 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-yui.html (next: http://localhost:59619/tests/dromaeo/cssquery-dojo.html) 17:55:43 INFO - PROCESS | 7156 | RSS: Main: 169562112 17:55:43 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | __start_tp_report 17:55:44 INFO - PROCESS | 7156 | _x_x_mozilla_page_load 17:55:44 INFO - PROCESS | 7156 | _x_x_mozilla_page_load_details 17:55:44 INFO - PROCESS | 7156 | |i|pagename|runs| 17:55:44 INFO - PROCESS | 7156 | |0;dojo.html;2568.7174410814805;2575.845449273045;2598.2465085125314;2599.701034381046;2613.673290838644;4722.858314250574;4738.502457241983;4743.051389722053;4779.044191161768;4814.494478079804;4761.619070474362;4782.952170478294;4811.2783082537635;4838.153323168449;4893.486183950678;4216.354546708588;4410.735355878642;4526.094781043788;4537.773111344436;4555.772211389434;4566.40636717228;4567.63458923287;4569.794359253825;4571.291449825282;4584.656150788687;4370.2570563004365;4401.361802538646;4403.119376124756;4472.619827314682;4485.618722408599;4391.758453285068;4404.911901761979;4429.180601588717;4442.822287108512;4471.9776401118115;4340.934885976713;4382.255016647177;4397.802098905525;4402.735835849827;4429.579189976947;4726.385569875929;4733.077049975256;4773.928391074137;4787.0904528139545;4828.927566086511;5115.028144652504;5143.922841157386;5152.407473140599;5175.353080864892;5195.610329225323;5194.6104042196985;5196.480351964811;5198.090334191539;5199;5265.157574788015;4739.644526660445;4841.709497430165;4843.636727245471;4844.128056949783;4861.173600487926;5177.948220517746;5241;5348.839534813884;5369.785208591613;5382.273393091882;5036.269740887551;5058.064258112261;5058.494150584986;5066.695998240118;5068.467810879804;5163.690178589221;5164.845054648292;5167.870803229949;5169.534741873174;5213.374395072539;5052.343195384577;5060.974695126501;5070.898582028339;5131.666441681279;5138.87152821175;5163.870903227449;5175;5178.741062946838;5179.119549676564;5196.76614552346;4389.429374181336;4399.14216727735;4402.207602631557;4405.493368262627;4432.335149727567;3746.662800347982;3817.4655548223272;3823.636754508317;3835.137094153793;3865.1496670732395;4407.030453300269;4416.33754936762;4443.178012067778;4450.866474005785;4485.596296333346;5132.948670513321;5142.408623008327;5165.74171291434;5173.301604283449;5206.947930520722;4413.713108647992;4424.247877860771;4427.269500532376;4434.933475997863;4498.752568608758;4477.417935668343;4523.32150177476;4618.468876079227;4625.259958406638;4639.721616703008;4870.318155458168;4892.584130348961;4900.92648610264;4903.141950158637;4927.926081108858;5220.817271395483;5227.764750586309;5230.660007099526;5236.136037553761;5243.868903277448;4767.237242041257;4804.759762011955;4843.782029808596;4849.248366503198;4874.098291815883;5171.482851714798;5182.144946084005;5184.351956005499;5213.061648903082;5226.137687281556;5101.872453188552;5117.513836185556;5253.947460525345;5279.47205279469;5320.973395133;5027.798888044437;5031.9245211322595;5038.345015148007;5053.797848086036;5110;4988.975055124701;5002.349694539686;5025.798968041384;5028;5062.240663900445;4894.19245824435;4953.851384458472;5000.574951129195;5008.899822003466;5043.218301163325;4979.278004689372;5081.974590127025;5114.053900028507;5131.692098474104;5192.948070519397;4956.851294461172;4979.128652485873;4998.900021999612;5001.64988450805;5088.363954505687 17:55:44 INFO - PROCESS | 7156 | |1;ext.html;534.788758440416;545.5090418623241;552.4889477233563;556.4407770190958;568.7753337431715;37972;39373.60626393735;39408.60591394085;39495.40756888649;39513.20973580526;40375.79812100943;40812.38781418281;40918.38622420666;40983.18033639333;41060.794696026474;7620.809479763008;7767.728129515468;7777.727779527718;7781.455298129134;9249.768755781091;9344.20574251186;9395.34232603718;9406.952965235165;9415.105564971316;9456.338056336024;9471.147596716293;9475.241980641533;9539.952300238523;9540.141387275144;9552.140307372336;9399.530023498866;9431.386959847623;9469;9476.336656434052;9496.287778416612;9419.340646154771;9496.43021418717;9535.713928582154;9555.23558115349;9562.713118606453;32452;32681.346373072643;32697.346053079043;32823.17942051468;32900.34199316024;3383.644717304672;3387.1532116970757;3421.4183588789965;3424.2124311408265;3447.4484082546924;24515.387115322083;24756.50486990268;24977.250682479556;25155.62266566003;25873;3475.7393195510185;3517.4196257617464;3529.347070791912;3543.1850674344787;3584.8207589620415;217935;218202;219661;219974.90012549996;220698;40307.395389069185;41435;46395;47033.5296647036;47074.293885591745;49457.25814112791;50313;50490;54164.72917635465;54398.72800635971;11995.820062699066;12066.517339306329;12138.514459421702;12147.635570932885;12187.45156467961;9652.22782177424;9725.416475011521;9739.707808765748;9746.366486178376;9769.853452198222;15860.92069539645;15916.840831591768;15990.920045399698;16014.599635008984;16020.11889346097;6601.768938087144;6629.734810607618;6683.699233534503;6734.494912881455;6886.10480637514;792.9801754956056;812;813.7233340664203;813.877918312246;814.5316443045273;25902.740972590032;26628.934842606468;26926.5961010585;27004.32489187786;27362.905483780425;927.0497739816742;934.9672761453317;946.7491114854569;948.9145976862116;961.1493827962304;14763.745081667963;14834.92582537102;14905.403783848742;14943.327550260265;14966.551003469913;309196;309395;310038;310751;311303;47775.76112119417;48461.5153848457;48622.999999999294;48663.270050949264;48664.27003594949;1179.722765150189;1212.805951047828;1217.1419149499582;1222.9327386993623;1223.4861358229386;24675.876620616782;25797.226083217534;26394.208173754818;26671.86664066667;26696.866515667298;40775.38836917508;41156.79421602993;41455;41627.1674566513;41695.374569380874;205168;205303;205909;206204;206870;22892.313230603108;23907.880460597586;24029.639555407033;24953;25115.246542603752;35177.64822351744;35209.47185792266;35233.647663523036;35448.29103417969;36172.638273616925;30850.382992340477;31038.22404439907;31073.8446307767;31089.212392683836;31589.210269743442;30217.848910755307;30585.54121688132;31201.219969500944;31676;31676.683233167372;30759.538606920465;30935.226619334695;31013.8449307752;31878.840605796824;34253.31493370169;26373.64834802236;27927.720722792514;28647.140585781624;29052.27369315784;29280.121596352143;22236;22556.66165007559;22793.31620051401;23062.654060188775;23091.19180828663 17:55:44 INFO - PROCESS | 7156 | |2;jquery.html;384.749912556838;384.9422586612006;393.94878665773456;397.28885295321373;417.38019041723055;17193.828061719378;17432.73850892236;17748.733768993443;18180.727289090675;18258.54353641158;11194.38430886301;11258.099352051817;11444.313341199533;11621.418929053534;11655.242409243394;4753.738544380067;4930.4083509978855;4938.234573641092;4943.431505376874;4949.059678661043;4701.764911754416;4826.155422801014;4829.806807727687;4847.51524847516;4888.682235654689;4833.661643684944;4843.152448321547;4848.612111031127;4856;4884.853454396356;4862.2220444728855;4880.414350277972;4885.316055752198;5236.738163091868;5480.177973304037;5350.411454739976;5396.136618141118;5397.8380648580605;5402.243685883979;5405.081136206854;12921.547745828851;17494.562635934075;19314.13086411115;21837.344879653636;22222.333330000125;2151.526664133888;2186.8797216153107;2196.7254093238344;2201.933941981743;2205.3273751505944;9011.414258073204;9461.574229159703;9784.608615655365;9795.266530442206;9887.209023278121;1697.6010637500178;1697.9745303820453;1734.4363081998401;1753.3074435597866;1767;74393.62803186003;78020.21979780187;78323;79112;79693.60153199255;10487.632932847313;10571.15430765537;10920.235583509237;10928;11125.276857004268;15370;15381.923090384476;15409.768853467207;15428.614284642974;15443.227838608025;6683.2648408675;6808.080909077211;6828.795136145924;6975.197852246955;7036.050133232051;6104.511639068864;6199.907001394983;6345.777897773556;6358.141650877073;6363.809085727436;4623;4638.234691275969;4748.7863046163;4756.6908150970075;4899.265110233494;1964.3321270768008;2005.428452890919;2008.3874418302557;2040;2051.466618679154;773.3272053313653;801.210807354755;806.0971711682953;807.8868958345836;816.4407380944073;17353.392631257844;17369.652606948042;18134.727979080326;18249.817501825077;18644.81355186458;791.192983157188;795.6459375577928;799.1648727080216;805.8025783682918;830.9002919649681;9642.662506812228;9734.75663108428;9887.505624718735;10076.59693612262;10203.38779673222;439158;472422;478447.58628964744;485281;486351;70364;70437.64781176062;78010.60994695104;87837.56081219681;92180;933.7012156110115;978.6134476881734;981.097390400833;983.0660872171466;984.9704508864745;16072.696010316802;16160.757588635945;16509.83490165083;16768.748468772734;16821.158942053095;35256.64743352534;39505.209895802494;40310.39534406928;40823.1835363297;42197.15605687931;55757;56314.718426407606;56504.434955649915;56660.71669641625;57678;7940.404469664682;8014.0383154019555;8111.513309201467;8140.145284745016;8231.670733170606;10210.693679189637;12311.753764924471;12574.622761317176;12631.536850314467;12679.556215532411;9861.506924653882;10187.643432479828;10498;10561.788764224519;10595.470226488798;10435.530401131815;10845.837312440477;11039.392833393918;11115.666530004113;11443.25618834773;10088.69733907984;10266.845997310196;10276.897231027595;10337.431441270803;10342.120919721607;7586.468947173645;7717.845643087219;7847.411444141598;8120.350371970347;8340.499570025819;5340.732963351895;9099.31755118382;9153.359264851397;9996.800063998824;10074.042965918226 17:55:44 INFO - PROCESS | 7156 | |3;mootools.html;1342.4831439895638;1357.4095268558176;1363.5704753002803;1366.781314989602;1373.9244341561214;7283.526570772896;7484.363829074521;7730.536167829934;7733.11069227039;7751.457397982143;7670.501417407864;7788.922110778891;7807.609619519029;7814.101378341493;7830.686772529092;2120.713703650003;2145.7639659637507;2149.795769401904;2159.125554150564;2165.815905648014;2129.882856442895;2150.3226483657677;2151.4621344663833;2159.524904521003;2162.027087810484;2058.50595856994;2068.855180137391;2069.14130635786;2087.060822629815;2090.634139025672;2115.566308906678;2128.733908261467;2131.2434085899513;2149.12960251097;2164.4047886831167;1795.3985414886029;1865.9533511662182;1998.850086243523;2017.515796208914;2073.3365323096614;7737.264959828807;7756.224377562255;7794.181610930884;7808.453408261424;7812.179721129313;4383.736975781463;4501.189785838547;4510.075434535945;4529.0715403342565;4541.227991241464;2925.224815423914;2942.1173647905757;2973.44991176633;3015.411994661042;3015.909522714322;1082.1775450657478;1085.8642669666292;1092.421016861057;1115.5370521233679;1129.4239937631867;10322.122619577345;10333.638322658746;10376.63681771142;10412.479376031244;10414.583416663325;3865.845366185321;3986.063275130342;4036.4348991141264;4061.5532291447917;4133.338665813455;8273.131321211185;8301.252887240178;8321.916780832235;8333.708320208763;8347.833043339098;4590.9540904591195;4626.306054091913;4637.443506779208;4648.697834640738;4664.976675116603;4100.425940368351;4110.630043296118;4189.973456503176;4201.810918508674;4239.872803815891;3258.332041931446;3314.784539004957;3374.4769560718128;3402.863885444604;3406.42090844557;1026.9435181064964;1045.3414348960107;1048.6958781953301;1063.0485715284776;1063.8351055586397;769.992300076992;798.1778767869104;798.8641930871765;802.6107337941094;812.3582369927809;5092;5222.947770522246;5242.842714718565;5277.1292736698015;5310.707911064928;547.2311402479522;547.2475346398702;561.1890817768285;574.6925394913785;576.9596128270981;3500.3524347995703;3546.13119785649;3546.2730140321173;3604.945925811115;3618.6924111450294;8451.788705282293;8616;8994;9015.098490151064;9073;8885.511296878734;9006.954965225132;9017.458952462874;9163.129502697233;9264.768380790534;6723.327667233335;6919.8962015569805;6926.515143939876;6935;6938.722451101899;4935.605151587936;4961.50384961501;5039.294498770102;5118.129917913889;5194.168932970707;7832.84334313322;8192.303654189222;8419.579021049045;8442.746717598482;8445.1977062179;8418.074011858569;8477.74566762998;8517.466855965986;8622.396432249683;8666.826663466569;6896.965515172392;6997.475189360716;7052.259512751292;7052.682629281592;7055.753048643272;7096.574205547684;7163.140423149255;7199.1361036675935;7248.855022899618;7257.818554535967;6369.777057802955;6544.934550654623;6567.802965911031;6657.833554161185;6691.230508491586;6315.96842015787;6426.228852537539;6454.967725161344;6476.643784591893;6483.124778154889;5774.509166720875;5791.218185544897;5793.913091303718;5802.187693722966;5955.076963070731;4456.710313829591;4542.136993971135;4580.267157254823;4620.5379462053525;4659.860204193879;4474.642028637766;4550.863474095782;4696;4706.129366067288;4805.8558243252755 17:55:44 INFO - PROCESS | 7156 | |4;prototype.html;352.7372107779704;363.02708740575247;364.89965259553617;366.6095608177291;368.52092280035964;5023.5981121510285;5069.44236134025;5070.75766437223;5072.771725272362;5074.644774865761;4952.826651067214;4986.35177426934;4987.728129327016;4992.900141997158;5018.397792264934;3769.1707824278683;3902.7072969527258;3933.2330195611867;3940.9014774630577;3951.451313902531;3902.0635047588657;3909.257241124177;3916.9608303917025;3924.62716041977;3949.782761948092;3913.256481268564;3918.8824335269987;3924.2151569686034;3926.725129240954;3933.6656384207377;3661.5972243053243;3825.5600605930395;3898.8440462381473;3918.373060310365;3921.2157568486273;3365.9663403366144;3382.8308584570673;3382.8646854125805;3384;3400.605751641815;4817.795551112222;4840.661153719241;4874.951250487521;4886.021161429627;4949.604031677457;4397.208502469554;4419.801108950105;4431.955680443219;4454.8886277842985;4466.53101424349;5032.572231360339;5193.376794784613;5229.633925625208;5230.92153617696;5268.4994925482015;3717.9070523237137;3733.4773131761303;3734.6265373462707;3772.358699021173;3788.6969042476535;5257.789688412459;5418.322709661293;5520.834374968757;5539.75639865855;5542.362628297717;3695.1685870678884;3790.507234059555;3791.7914514701956;3801.125741079567;3816.2254551633623;3855.20968201518;3864.415589608247;3867.825947832298;3902.843886244518;3917.745346552465;4401.933970990438;4426.291793313118;4432.002799370181;4435.467743870756;4439.733615983051;5077.923831142536;5217.530422262014;5233.476652334736;5264.736763161826;5268.868278292996;1286.311823174597;1305.2364366845502;1309.8755618216255;1310.600266918599;1313.6059182245288;847.8050048488882;898.9460632362079;902.2421166220275;913.6254135804288;916.9684105381446;4432.49026361966;4434.268345722984;4438.291257865745;4447;4470.932936005963;5252.816151434758;5287.769784172647;5297.841064768063;5298.682079075268;5323.893522129613;4309.224339618836;4452.4211852458975;4473.753943533137;4489.775511224426;4515.300128480025;2754.5868119781794;2788.860556972184;2792.2181789098677;2795.3710415156834;2802.621646077794;4862.80548778052;4890.388701412324;4894.19245824435;4897.681650692693;4905.681130726492;5007.349044624176;5301.416844147141;5315.202719592092;5371.704556249444;5375.892482150335;4844.4186697596515;4871.537203965689;4877.585405240594;4908.533689299511;4911;5274.624240486015;5275.575594589516;5281;5292.894142117213;5294.417614062527;4886.780094895667;5207.3751149862255;5228.320318358589;5238.68567885928;5269.552088072403;4878.000049948689;4898.8775280618265;4901.534354236342;4914.8053765053;5014.7994080236385;3821.178446633987;3827.578966313759;3835.558910725302;3839.865604703822;3854.730168888263;5432.239486471818;5433.864153396039;5438.721900353335;5438.864028399322;5444.945550544444;4962.826301079445;5215.478452154754;5268.947310526999;5301.3373328333955;5303.257543943928;5174.689518628894;5176.559992400537;5220.676798824638;5241;5251.816186433456;5195.3246078009615;5201.349831271091;5216.608754343363;5226.45122262157;5246.291750613618;5009.198528235464;5223.399309079353;5249.501297376743;5250.2912106866615;5279.287296214962;5118.232265160255;5152.76812543444;5155.716435596079;5177.741112944413;5187.429382767968 17:55:44 INFO - PROCESS | 7156 | |5;yui.html;674.0596867370022;688.6074937285746;718.9928100718992;721.4336745654659;749.2994050562722;12171.087168462367;13063.804042939364;13095.345232738373;13113.934430327836;13194.406251718672;12661.24032558045;12814.551490697828;12874.549390771324;12888.935555322234;12952.287624180666;782.7847341980959;790.644210105452;814.5235037503068;815.2662603656727;826.4297634632114;819.2503858969036;823.3948048184579;823.9176082391742;826.3017750001239;828.3828547731918;861.1947828780079;862.7153039496982;864.0668078475263;866.384866744609;868.847951608466;859.5788063848669;861.5046348349692;861.7457849934284;861.7630151708299;862.7584276402617;622.4366947912147;625.0655270370825;626.2297374229678;626.8307556959641;627.9277883043463;12649.810252846215;13027.478900843955;13712.862871371259;13733;13746.243956582384;11528.711782205428;11692.356920369377;11716.648500544912;11917.642470725892;11987.820182697267;10246.129079028291;10250.231232657581;10444.216683748673;10486.9475652622;10533.736656583571;3177.7140057394713;3204.247001954539;3218.662040485762;3235.126515840733;3238.044776790852;56525.152122718195;56810.999999999585;57294.71352643252;57334.42665573374;57532.42467575312;9672.661456848977;9740.610375585038;9845.458499782437;9907.653232136985;9925.404475731479;17679.20443580042;18307.816921830876;18578.721319180222;18723.81276187248;19418.61162776765;6392.26488953767;6476.967615161894;6518.445932095825;6541.92058310383;6687.899681504781;3295.967040329566;3378.3918894598714;3390.2710917152435;3417.333619944137;3465.1510379956567;3101.7673674474504;3166.1609673436556;3177.602799650044;3177.8411079445937;3213.7268332192025;542.378976072395;547.3650565344182;556.4824713016852;561.7472137538124;563.132775525694;641.3650486018807;659.9406053455212;668.6021817018866;677.2009029345321;688.9552179108342;8888.733337999742;9263.212626926786;9312.953435232781;9343.95025064037;9345.859812102824;526.7866514061811;530.0856023359673;554.8862483190936;674.2448457727377;684.6474065856088;3736.9065773355883;4094.7952602369764;4212.199682060399;4241.2365774160335;4583.931241031387;58065.129023064685;59433.405665943654;60430.39569604336;60482.697586512666;62790.68604656948;52638.21042684363;52893;53203.73398133062;53763.19355209675;54612.453875460735;40137.799311003255;40712;41797.1640567193;48283.517164828605;48294;9332.113449222314;9663.710088697351;9694.56374463165;9823.36148150368;9839.557219925264;33437.16407089842;33561.49657755184;33769.662303377634;33836;34287.48568771421;40636.390454142624;41170.38244426276;41801;42959.355609666505;43751;11281.492332844877;11317.943410282896;11318.32090074598;11567.132465064986;11809;11814.173007889365;11884.821727674265;12279.570215042431;12389.194702344319;12788.936055319664;11778.941105294418;11873.82189267179;12075;12229.266244025386;12606.87393126057;11867.525298987945;11938.880611193777;12448.564300249811;12494.437750301076;12548.244328652521;11257.268277561932;11905.107116966436;12007.099467540143;12231;12279;8777.85883368813;9192.816143677222;9231.215346695606;9435.669751558662;9510.334276600572;9034.683000556899;9347.906520934976;9844.114029737359;10274.537645806106;10404 17:55:44 INFO - PROCESS | 7156 | __end_tp_report 17:55:44 INFO - PROCESS | 7156 | __start_cc_report 17:55:44 INFO - PROCESS | 7156 | _x_x_mozilla_cycle_collect,388 17:55:44 INFO - PROCESS | 7156 | __end_cc_report 17:55:44 INFO - PROCESS | 7156 | __startTimestamp1486173343996__endTimestamp 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | ------- Summary: start ------- 17:55:44 INFO - PROCESS | 7156 | Number of tests: 6 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#0] dojo.html Cycles:165 Average:4775.08 Median:4894.19 stddev:520.85 (10.6%) stddev-sans-first:492.85 17:55:44 INFO - PROCESS | 7156 | Values: 2568.7 2575.8 2598.2 2599.7 2613.7 4722.9 4738.5 4743.1 4779.0 4814.5 4761.6 4783.0 4811.3 4838.2 4893.5 4216.4 4410.7 4526.1 4537.8 4555.8 4566.4 4567.6 4569.8 4571.3 4584.7 4370.3 4401.4 4403.1 4472.6 4485.6 4391.8 4404.9 4429.2 4442.8 4472.0 4340.9 4382.3 4397.8 4402.7 4429.6 4726.4 4733.1 4773.9 4787.1 4828.9 5115.0 5143.9 5152.4 5175.4 5195.6 5194.6 5196.5 5198.1 5199.0 5265.2 4739.6 4841.7 4843.6 4844.1 4861.2 5177.9 5241.0 5348.8 5369.8 5382.3 5036.3 5058.1 5058.5 5066.7 5068.5 5163.7 5164.8 5167.9 5169.5 5213.4 5052.3 5061.0 5070.9 5131.7 5138.9 5163.9 5175.0 5178.7 5179.1 5196.8 4389.4 4399.1 4402.2 4405.5 4432.3 3746.7 3817.5 3823.6 3835.1 3865.1 4407.0 4416.3 4443.2 4450.9 4485.6 5132.9 5142.4 5165.7 5173.3 5206.9 4413.7 4424.2 4427.3 4434.9 4498.8 4477.4 4523.3 4618.5 4625.3 4639.7 4870.3 4892.6 4900.9 4903.1 4927.9 5220.8 5227.8 5230.7 5236.1 5243.9 4767.2 4804.8 4843.8 4849.2 4874.1 5171.5 5182.1 5184.4 5213.1 5226.1 5101.9 5117.5 5253.9 5279.5 5321.0 5027.8 5031.9 5038.3 5053.8 5110.0 4989.0 5002.3 5025.8 5028.0 5062.2 4894.2 4953.9 5000.6 5008.9 5043.2 4979.3 5082.0 5114.1 5131.7 5192.9 4956.9 4979.1 4998.9 5001.6 5088.4 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#1] ext.html Cycles:180 Average:39784.63 Median:3496.58 stddev:65164.82 (1863.7%) stddev-sans-first:65280.98 17:55:44 INFO - PROCESS | 7156 | Values: 534.8 545.5 552.5 556.4 568.8 37972.0 39373.6 39408.6 39495.4 39513.2 40375.8 40812.4 40918.4 40983.2 41060.8 7620.8 7767.7 7777.7 7781.5 9249.8 9344.2 9395.3 9407.0 9415.1 9456.3 9471.1 9475.2 9540.0 9540.1 9552.1 9399.5 9431.4 9469.0 9476.3 9496.3 9419.3 9496.4 9535.7 9555.2 9562.7 32452.0 32681.3 32697.3 32823.2 32900.3 3383.6 3387.2 3421.4 3424.2 3447.4 24515.4 24756.5 24977.3 25155.6 25873.0 3475.7 3517.4 3529.3 3543.2 3584.8 217935.0 218202.0 219661.0 219974.9 220698.0 40307.4 41435.0 46395.0 47033.5 47074.3 49457.3 50313.0 50490.0 54164.7 54398.7 11995.8 12066.5 12138.5 12147.6 12187.5 9652.2 9725.4 9739.7 9746.4 9769.9 15860.9 15916.8 15990.9 16014.6 16020.1 6601.8 6629.7 6683.7 6734.5 6886.1 793.0 812.0 813.7 813.9 814.5 25902.7 26628.9 26926.6 27004.3 27362.9 927.0 935.0 946.7 948.9 961.1 14763.7 14834.9 14905.4 14943.3 14966.6 309196.0 309395.0 310038.0 310751.0 311303.0 47775.8 48461.5 48623.0 48663.3 48664.3 1179.7 1212.8 1217.1 1222.9 1223.5 24675.9 25797.2 26394.2 26671.9 26696.9 40775.4 41156.8 41455.0 41627.2 41695.4 205168.0 205303.0 205909.0 206204.0 206870.0 22892.3 23907.9 24029.6 24953.0 25115.2 35177.6 35209.5 35233.6 35448.3 36172.6 30850.4 31038.2 31073.8 31089.2 31589.2 30217.8 30585.5 31201.2 31676.0 31676.7 30759.5 30935.2 31013.8 31878.8 34253.3 26373.6 27927.7 28647.1 29052.3 29280.1 22236.0 22556.7 22793.3 23062.7 23091.2 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#2] jquery.html Cycles:180 Average:27069.69 Median:241636.87 stddev:77890.29 (32.2%) stddev-sans-first:78083.02 17:55:44 INFO - PROCESS | 7156 | Values: 384.7 384.9 393.9 397.3 417.4 17193.8 17432.7 17748.7 18180.7 18258.5 11194.4 11258.1 11444.3 11621.4 11655.2 4753.7 4930.4 4938.2 4943.4 4949.1 4701.8 4826.2 4829.8 4847.5 4888.7 4833.7 4843.2 4848.6 4856.0 4884.9 4862.2 4880.4 4885.3 5236.7 5480.2 5350.4 5396.1 5397.8 5402.2 5405.1 12921.5 17494.6 19314.1 21837.3 22222.3 2151.5 2186.9 2196.7 2201.9 2205.3 9011.4 9461.6 9784.6 9795.3 9887.2 1697.6 1698.0 1734.4 1753.3 1767.0 74393.6 78020.2 78323.0 79112.0 79693.6 10487.6 10571.2 10920.2 10928.0 11125.3 15370.0 15381.9 15409.8 15428.6 15443.2 6683.3 6808.1 6828.8 6975.2 7036.1 6104.5 6199.9 6345.8 6358.1 6363.8 4623.0 4638.2 4748.8 4756.7 4899.3 1964.3 2005.4 2008.4 2040.0 2051.5 773.3 801.2 806.1 807.9 816.4 17353.4 17369.7 18134.7 18249.8 18644.8 791.2 795.6 799.2 805.8 830.9 9642.7 9734.8 9887.5 10076.6 10203.4 439158.0 472422.0 478447.6 485281.0 486351.0 70364.0 70437.6 78010.6 87837.6 92180.0 933.7 978.6 981.1 983.1 985.0 16072.7 16160.8 16509.8 16768.7 16821.2 35256.6 39505.2 40310.4 40823.2 42197.2 55757.0 56314.7 56504.4 56660.7 57678.0 7940.4 8014.0 8111.5 8140.1 8231.7 10210.7 12311.8 12574.6 12631.5 12679.6 9861.5 10187.6 10498.0 10561.8 10595.5 10435.5 10845.8 11039.4 11115.7 11443.3 10088.7 10266.8 10276.9 10337.4 10342.1 7586.5 7717.8 7847.4 8120.4 8340.5 5340.7 9099.3 9153.4 9996.8 10074.0 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#3] mootools.html Cycles:180 Average:4958.23 Median:4948.55 stddev:2742.88 (55.4%) stddev-sans-first:2737.11 17:55:44 INFO - PROCESS | 7156 | Values: 1342.5 1357.4 1363.6 1366.8 1373.9 7283.5 7484.4 7730.5 7733.1 7751.5 7670.5 7788.9 7807.6 7814.1 7830.7 2120.7 2145.8 2149.8 2159.1 2165.8 2129.9 2150.3 2151.5 2159.5 2162.0 2058.5 2068.9 2069.1 2087.1 2090.6 2115.6 2128.7 2131.2 2149.1 2164.4 1795.4 1866.0 1998.9 2017.5 2073.3 7737.3 7756.2 7794.2 7808.5 7812.2 4383.7 4501.2 4510.1 4529.1 4541.2 2925.2 2942.1 2973.4 3015.4 3015.9 1082.2 1085.9 1092.4 1115.5 1129.4 10322.1 10333.6 10376.6 10412.5 10414.6 3865.8 3986.1 4036.4 4061.6 4133.3 8273.1 8301.3 8321.9 8333.7 8347.8 4591.0 4626.3 4637.4 4648.7 4665.0 4100.4 4110.6 4190.0 4201.8 4239.9 3258.3 3314.8 3374.5 3402.9 3406.4 1026.9 1045.3 1048.7 1063.0 1063.8 770.0 798.2 798.9 802.6 812.4 5092.0 5222.9 5242.8 5277.1 5310.7 547.2 547.2 561.2 574.7 577.0 3500.4 3546.1 3546.3 3604.9 3618.7 8451.8 8616.0 8994.0 9015.1 9073.0 8885.5 9007.0 9017.5 9163.1 9264.8 6723.3 6919.9 6926.5 6935.0 6938.7 4935.6 4961.5 5039.3 5118.1 5194.2 7832.8 8192.3 8419.6 8442.7 8445.2 8418.1 8477.7 8517.5 8622.4 8666.8 6897.0 6997.5 7052.3 7052.7 7055.8 7096.6 7163.1 7199.1 7248.9 7257.8 6369.8 6544.9 6567.8 6657.8 6691.2 6316.0 6426.2 6455.0 6476.6 6483.1 5774.5 5791.2 5793.9 5802.2 5955.1 4456.7 4542.1 4580.3 4620.5 4659.9 4474.6 4550.9 4696.0 4706.1 4805.9 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#4] prototype.html Cycles:180 Average:4312.64 Median:4892.29 stddev:1244.18 (25.4%) stddev-sans-first:1211.65 17:55:44 INFO - PROCESS | 7156 | Values: 352.7 363.0 364.9 366.6 368.5 5023.6 5069.4 5070.8 5072.8 5074.6 4952.8 4986.4 4987.7 4992.9 5018.4 3769.2 3902.7 3933.2 3940.9 3951.5 3902.1 3909.3 3917.0 3924.6 3949.8 3913.3 3918.9 3924.2 3926.7 3933.7 3661.6 3825.6 3898.8 3918.4 3921.2 3366.0 3382.8 3382.9 3384.0 3400.6 4817.8 4840.7 4875.0 4886.0 4949.6 4397.2 4419.8 4432.0 4454.9 4466.5 5032.6 5193.4 5229.6 5230.9 5268.5 3717.9 3733.5 3734.6 3772.4 3788.7 5257.8 5418.3 5520.8 5539.8 5542.4 3695.2 3790.5 3791.8 3801.1 3816.2 3855.2 3864.4 3867.8 3902.8 3917.7 4401.9 4426.3 4432.0 4435.5 4439.7 5077.9 5217.5 5233.5 5264.7 5268.9 1286.3 1305.2 1309.9 1310.6 1313.6 847.8 898.9 902.2 913.6 917.0 4432.5 4434.3 4438.3 4447.0 4470.9 5252.8 5287.8 5297.8 5298.7 5323.9 4309.2 4452.4 4473.8 4489.8 4515.3 2754.6 2788.9 2792.2 2795.4 2802.6 4862.8 4890.4 4894.2 4897.7 4905.7 5007.3 5301.4 5315.2 5371.7 5375.9 4844.4 4871.5 4877.6 4908.5 4911.0 5274.6 5275.6 5281.0 5292.9 5294.4 4886.8 5207.4 5228.3 5238.7 5269.6 4878.0 4898.9 4901.5 4914.8 5014.8 3821.2 3827.6 3835.6 3839.9 3854.7 5432.2 5433.9 5438.7 5438.9 5444.9 4962.8 5215.5 5268.9 5301.3 5303.3 5174.7 5176.6 5220.7 5241.0 5251.8 5195.3 5201.3 5216.6 5226.5 5246.3 5009.2 5223.4 5249.5 5250.3 5279.3 5118.2 5152.8 5155.7 5177.7 5187.4 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - PROCESS | 7156 | [#5] yui.html Cycles:180 Average:14027.70 Median:48288.76 stddev:16617.33 (34.4%) stddev-sans-first:16633.69 17:55:44 INFO - PROCESS | 7156 | Values: 674.1 688.6 719.0 721.4 749.3 12171.1 13063.8 13095.3 13113.9 13194.4 12661.2 12814.6 12874.5 12888.9 12952.3 782.8 790.6 814.5 815.3 826.4 819.3 823.4 823.9 826.3 828.4 861.2 862.7 864.1 866.4 868.8 859.6 861.5 861.7 861.8 862.8 622.4 625.1 626.2 626.8 627.9 12649.8 13027.5 13712.9 13733.0 13746.2 11528.7 11692.4 11716.6 11917.6 11987.8 10246.1 10250.2 10444.2 10486.9 10533.7 3177.7 3204.2 3218.7 3235.1 3238.0 56525.2 56811.0 57294.7 57334.4 57532.4 9672.7 9740.6 9845.5 9907.7 9925.4 17679.2 18307.8 18578.7 18723.8 19418.6 6392.3 6477.0 6518.4 6541.9 6687.9 3296.0 3378.4 3390.3 3417.3 3465.2 3101.8 3166.2 3177.6 3177.8 3213.7 542.4 547.4 556.5 561.7 563.1 641.4 659.9 668.6 677.2 689.0 8888.7 9263.2 9313.0 9344.0 9345.9 526.8 530.1 554.9 674.2 684.6 3736.9 4094.8 4212.2 4241.2 4583.9 58065.1 59433.4 60430.4 60482.7 62790.7 52638.2 52893.0 53203.7 53763.2 54612.5 40137.8 40712.0 41797.2 48283.5 48294.0 9332.1 9663.7 9694.6 9823.4 9839.6 33437.2 33561.5 33769.7 33836.0 34287.5 40636.4 41170.4 41801.0 42959.4 43751.0 11281.5 11317.9 11318.3 11567.1 11809.0 11814.2 11884.8 12279.6 12389.2 12788.9 11778.9 11873.8 12075.0 12229.3 12606.9 11867.5 11938.9 12448.6 12494.4 12548.2 11257.3 11905.1 12007.1 12231.0 12279.0 8777.9 9192.8 9231.2 9435.7 9510.3 9034.7 9347.9 9844.1 10274.5 10404.0 17:55:44 INFO - PROCESS | 7156 | -------- Summary: end -------- 17:55:44 INFO - PROCESS | 7156 | 17:55:44 INFO - TEST-INFO | 7156: exit 0 17:55:44 INFO - TEST-OK | dromaeo_css | took 1120519ms 17:55:44 INFO - TEST-START | kraken 17:55:44 INFO - operating with platform_type : linux_ 17:55:44 INFO - Initialising browser for kraken test... 17:55:44 INFO - TEST-INFO | started process 7512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQbPny2/profile http://localhost:59619/getInfo.html) 17:55:48 INFO - PROCESS | 7512 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:55:49 INFO - PROCESS | 7512 | __metrics Screen width/height:1600/1200 17:55:49 INFO - PROCESS | 7512 | colorDepth:24 17:55:49 INFO - PROCESS | 7512 | Browser inner width/height: 1024/697 17:55:49 INFO - PROCESS | 7512 | __metrics 17:55:49 INFO - PROCESS | 7512 | 1486173349548 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) 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:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpQbPny2/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpQbPny2/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpQbPny2/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpQbPny2/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:55:49 ERROR - PROCESS | 7512 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:55:50 INFO - TEST-INFO | 7512: exit 0 17:55:50 INFO - Browser initialized. 17:55:50 INFO - Running cycle 1/1 for kraken test... 17:55:50 INFO - TEST-INFO | started process 7631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQbPny2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:02 INFO - PROCESS | 7631 | RSS: Main: 159707136 17:56:02 INFO - PROCESS | 7631 | 17:56:05 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:06 INFO - PROCESS | 7631 | RSS: Main: 166023168 17:56:06 INFO - PROCESS | 7631 | 17:56:09 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-dft) 17:56:09 INFO - PROCESS | 7631 | RSS: Main: 165117952 17:56:09 INFO - PROCESS | 7631 | 17:56:12 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-fft) 17:56:13 INFO - PROCESS | 7631 | RSS: Main: 161669120 17:56:13 INFO - PROCESS | 7631 | 17:56:15 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-oscillator) 17:56:16 INFO - PROCESS | 7631 | RSS: Main: 162693120 17:56:16 INFO - PROCESS | 7631 | 17:56:18 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:19 INFO - PROCESS | 7631 | RSS: Main: 163225600 17:56:19 INFO - PROCESS | 7631 | 17:56:22 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:22 INFO - PROCESS | 7631 | RSS: Main: 166498304 17:56:22 INFO - PROCESS | 7631 | 17:56:26 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:27 INFO - PROCESS | 7631 | RSS: Main: 163483648 17:56:27 INFO - PROCESS | 7631 | 17:56:30 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59619/tests/kraken/driver.html?testName=json-parse-financial) 17:56:30 INFO - PROCESS | 7631 | RSS: Main: 165130240 17:56:30 INFO - PROCESS | 7631 | 17:56:32 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59619/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:33 INFO - PROCESS | 7631 | RSS: Main: 164843520 17:56:33 INFO - PROCESS | 7631 | 17:56:35 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:35 INFO - PROCESS | 7631 | RSS: Main: 164978688 17:56:35 INFO - PROCESS | 7631 | 17:56:37 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:38 INFO - PROCESS | 7631 | RSS: Main: 165933056 17:56:38 INFO - PROCESS | 7631 | 17:56:41 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:42 INFO - PROCESS | 7631 | RSS: Main: 166055936 17:56:42 INFO - PROCESS | 7631 | 17:56:45 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:45 INFO - PROCESS | 7631 | RSS: Main: 168407040 17:56:45 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59619/tests/kraken/driver.html?testName=ai-astar) 17:56:47 INFO - PROCESS | 7631 | RSS: Main: 170041344 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | __start_tp_report 17:56:47 INFO - PROCESS | 7631 | _x_x_mozilla_page_load 17:56:47 INFO - PROCESS | 7631 | _x_x_mozilla_page_load_details 17:56:47 INFO - PROCESS | 7631 | |i|pagename|runs| 17:56:47 INFO - PROCESS | 7631 | |0;ai-astar;111;116;116;117;115;117;116;116;114;117 17:56:47 INFO - PROCESS | 7631 | |1;audio-beat-detection;157;131;132;175;128;126;125;127;152;126 17:56:47 INFO - PROCESS | 7631 | |2;audio-dft;163;166;168;170;166;162;163;163;162;163 17:56:47 INFO - PROCESS | 7631 | |3;audio-fft;76;76;76;117;77;77;77;78;96;78 17:56:47 INFO - PROCESS | 7631 | |4;audio-oscillator;85;85;109;86;88;89;98;85;85;110 17:56:47 INFO - PROCESS | 7631 | |5;imaging-gaussian-blur;118;118;117;118;121;117;119;121;119;118 17:56:47 INFO - PROCESS | 7631 | |6;imaging-darkroom;151;150;150;150;150;155;151;151;151;149 17:56:47 INFO - PROCESS | 7631 | |7;imaging-desaturate;97;96;96;96;97;96;96;96;95;97 17:56:47 INFO - PROCESS | 7631 | |8;json-parse-financial;67;66;66;66;68;65;69;67;66;65 17:56:47 INFO - PROCESS | 7631 | |9;json-stringify-tinderbox;70;65;66;66;66;66;65;65;65;66 17:56:47 INFO - PROCESS | 7631 | |10;stanford-crypto-aes;87;87;85;86;86;89;86;86;91;88 17:56:47 INFO - PROCESS | 7631 | |11;stanford-crypto-ccm;140;133;136;140;133;143;137;141;203;132 17:56:47 INFO - PROCESS | 7631 | |12;stanford-crypto-pbkdf2;175;179;176;183;176;179;179;177;181;181 17:56:47 INFO - PROCESS | 7631 | |13;stanford-crypto-sha256-iterative;70;70;74;69;69;68;67;67;67;66 17:56:47 INFO - PROCESS | 7631 | __end_tp_report 17:56:47 INFO - PROCESS | 7631 | __start_cc_report 17:56:47 INFO - PROCESS | 7631 | _x_x_mozilla_cycle_collect,923 17:56:47 INFO - PROCESS | 7631 | __end_cc_report 17:56:47 INFO - PROCESS | 7631 | __startTimestamp1486173407819__endTimestamp 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | ------- Summary: start ------- 17:56:47 INFO - PROCESS | 7631 | Number of tests: 14 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.84 (1.6%) stddev-sans-first:1.00 17:56:47 INFO - PROCESS | 7631 | Values: 111.0 116.0 116.0 117.0 115.0 117.0 116.0 116.0 114.0 117.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:131.50 stddev:17.28 (13.1%) stddev-sans-first:16.90 17:56:47 INFO - PROCESS | 7631 | Values: 157.0 131.0 132.0 175.0 128.0 126.0 125.0 127.0 152.0 126.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.76 (1.7%) stddev-sans-first:2.86 17:56:47 INFO - PROCESS | 7631 | Values: 163.0 166.0 168.0 170.0 166.0 162.0 163.0 163.0 162.0 163.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:13.46 (17.5%) stddev-sans-first:14.05 17:56:47 INFO - PROCESS | 7631 | Values: 76.0 76.0 76.0 117.0 77.0 77.0 77.0 78.0 96.0 78.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.50 stddev:10.03 (11.7%) stddev-sans-first:10.32 17:56:47 INFO - PROCESS | 7631 | Values: 85.0 85.0 109.0 86.0 88.0 89.0 98.0 85.0 85.0 110.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.43 (1.2%) stddev-sans-first:1.50 17:56:47 INFO - PROCESS | 7631 | Values: 118.0 118.0 117.0 118.0 121.0 117.0 119.0 121.0 119.0 118.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.62 (1.1%) stddev-sans-first:1.72 17:56:47 INFO - PROCESS | 7631 | Values: 151.0 150.0 150.0 150.0 150.0 155.0 151.0 151.0 151.0 149.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:56:47 INFO - PROCESS | 7631 | Values: 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 97.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 17:56:47 INFO - PROCESS | 7631 | Values: 67.0 66.0 66.0 66.0 68.0 65.0 69.0 67.0 66.0 65.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:0.53 17:56:47 INFO - PROCESS | 7631 | Values: 70.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 66.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:1.79 (2.1%) stddev-sans-first:1.90 17:56:47 INFO - PROCESS | 7631 | Values: 87.0 87.0 85.0 86.0 86.0 89.0 86.0 86.0 91.0 88.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.00 stddev:21.14 (15.1%) stddev-sans-first:22.38 17:56:47 INFO - PROCESS | 7631 | Values: 140.0 133.0 136.0 140.0 133.0 143.0 137.0 141.0 203.0 132.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.00 stddev:2.59 (1.4%) stddev-sans-first:2.40 17:56:47 INFO - PROCESS | 7631 | Values: 175.0 179.0 176.0 183.0 176.0 179.0 179.0 177.0 181.0 181.0 17:56:47 INFO - PROCESS | 7631 | 17:56:47 INFO - PROCESS | 7631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.31 (3.4%) stddev-sans-first:2.40 17:56:47 INFO - PROCESS | 7631 | Values: 70.0 70.0 74.0 69.0 69.0 68.0 67.0 67.0 67.0 66.0 17:56:47 INFO - PROCESS | 7631 | -------- Summary: end -------- 17:56:47 INFO - PROCESS | 7631 | 17:56:48 INFO - TEST-INFO | 7631: exit 0 17:56:49 INFO - TEST-OK | kraken | took 64194ms 17:56:49 INFO - SUITE-END | took 1184s 17:56:49 INFO - Completed test suite (00:19:45) 17:56:49 INFO - javascript benchmark 17:56:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6319.644529929155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.7174410814805, 2575.845449273045, 2598.2465085125314, 2599.701034381046, 2613.673290838644, 4722.858314250574, 4738.502457241983, 4743.051389722053, 4779.044191161768, 4814.494478079804, 4761.619070474362, 4782.952170478294, 4811.2783082537635, 4838.153323168449, 4893.486183950678, 4216.354546708588, 4410.735355878642, 4526.094781043788, 4537.773111344436, 4555.772211389434, 4566.40636717228, 4567.63458923287, 4569.794359253825, 4571.291449825282, 4584.656150788687, 4370.2570563004365, 4401.361802538646, 4403.119376124756, 4472.619827314682, 4485.618722408599, 4391.758453285068, 4404.911901761979, 4429.180601588717, 4442.822287108512, 4471.9776401118115, 4340.934885976713, 4382.255016647177, 4397.802098905525, 4402.735835849827, 4429.579189976947, 4726.385569875929, 4733.077049975256, 4773.928391074137, 4787.0904528139545, 4828.927566086511, 5115.028144652504, 5143.922841157386, 5152.407473140599, 5175.353080864892, 5195.610329225323, 5194.6104042196985, 5196.480351964811, 5198.090334191539, 5199.0, 5265.157574788015, 4739.644526660445, 4841.709497430165, 4843.636727245471, 4844.128056949783, 4861.173600487926, 5177.948220517746, 5241.0, 5348.839534813884, 5369.785208591613, 5382.273393091882, 5036.269740887551, 5058.064258112261, 5058.494150584986, 5066.695998240118, 5068.467810879804, 5163.690178589221, 5164.845054648292, 5167.870803229949, 5169.534741873174, 5213.374395072539, 5052.343195384577, 5060.974695126501, 5070.898582028339, 5131.666441681279, 5138.87152821175, 5163.870903227449, 5175.0, 5178.741062946838, 5179.119549676564, 5196.76614552346, 4389.429374181336, 4399.14216727735, 4402.207602631557, 4405.493368262627, 4432.335149727567, 3746.662800347982, 3817.4655548223272, 3823.636754508317, 3835.137094153793, 3865.1496670732395, 4407.030453300269, 4416.33754936762, 4443.178012067778, 4450.866474005785, 4485.596296333346, 5132.948670513321, 5142.408623008327, 5165.74171291434, 5173.301604283449, 5206.947930520722, 4413.713108647992, 4424.247877860771, 4427.269500532376, 4434.933475997863, 4498.752568608758, 4477.417935668343, 4523.32150177476, 4618.468876079227, 4625.259958406638, 4639.721616703008, 4870.318155458168, 4892.584130348961, 4900.92648610264, 4903.141950158637, 4927.926081108858, 5220.817271395483, 5227.764750586309, 5230.660007099526, 5236.136037553761, 5243.868903277448, 4767.237242041257, 4804.759762011955, 4843.782029808596, 4849.248366503198, 4874.098291815883, 5171.482851714798, 5182.144946084005, 5184.351956005499, 5213.061648903082, 5226.137687281556, 5101.872453188552, 5117.513836185556, 5253.947460525345, 5279.47205279469, 5320.973395133, 5027.798888044437, 5031.9245211322595, 5038.345015148007, 5053.797848086036, 5110.0, 4988.975055124701, 5002.349694539686, 5025.798968041384, 5028.0, 5062.240663900445, 4894.19245824435, 4953.851384458472, 5000.574951129195, 5008.899822003466, 5043.218301163325, 4979.278004689372, 5081.974590127025, 5114.053900028507, 5131.692098474104, 5192.948070519397, 4956.851294461172, 4979.128652485873, 4998.900021999612, 5001.64988450805, 5088.363954505687], "value": 4739.8179008947955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.788758440416, 545.5090418623241, 552.4889477233563, 556.4407770190958, 568.7753337431715, 37972.0, 39373.60626393735, 39408.60591394085, 39495.40756888649, 39513.20973580526, 40375.79812100943, 40812.38781418281, 40918.38622420666, 40983.18033639333, 41060.794696026474, 7620.809479763008, 7767.728129515468, 7777.727779527718, 7781.455298129134, 9249.768755781091, 9344.20574251186, 9395.34232603718, 9406.952965235165, 9415.105564971316, 9456.338056336024, 9471.147596716293, 9475.241980641533, 9539.952300238523, 9540.141387275144, 9552.140307372336, 9399.530023498866, 9431.386959847623, 9469.0, 9476.336656434052, 9496.287778416612, 9419.340646154771, 9496.43021418717, 9535.713928582154, 9555.23558115349, 9562.713118606453, 32452.0, 32681.346373072643, 32697.346053079043, 32823.17942051468, 32900.34199316024, 3383.644717304672, 3387.1532116970757, 3421.4183588789965, 3424.2124311408265, 3447.4484082546924, 24515.387115322083, 24756.50486990268, 24977.250682479556, 25155.62266566003, 25873.0, 3475.7393195510185, 3517.4196257617464, 3529.347070791912, 3543.1850674344787, 3584.8207589620415, 217935.0, 218202.0, 219661.0, 219974.90012549996, 220698.0, 40307.395389069185, 41435.0, 46395.0, 47033.5296647036, 47074.293885591745, 49457.25814112791, 50313.0, 50490.0, 54164.72917635465, 54398.72800635971, 11995.820062699066, 12066.517339306329, 12138.514459421702, 12147.635570932885, 12187.45156467961, 9652.22782177424, 9725.416475011521, 9739.707808765748, 9746.366486178376, 9769.853452198222, 15860.92069539645, 15916.840831591768, 15990.920045399698, 16014.599635008984, 16020.11889346097, 6601.768938087144, 6629.734810607618, 6683.699233534503, 6734.494912881455, 6886.10480637514, 792.9801754956056, 812.0, 813.7233340664203, 813.877918312246, 814.5316443045273, 25902.740972590032, 26628.934842606468, 26926.5961010585, 27004.32489187786, 27362.905483780425, 927.0497739816742, 934.9672761453317, 946.7491114854569, 948.9145976862116, 961.1493827962304, 14763.745081667963, 14834.92582537102, 14905.403783848742, 14943.327550260265, 14966.551003469913, 309196.0, 309395.0, 310038.0, 310751.0, 311303.0, 47775.76112119417, 48461.5153848457, 48622.999999999294, 48663.270050949264, 48664.27003594949, 1179.722765150189, 1212.805951047828, 1217.1419149499582, 1222.9327386993623, 1223.4861358229386, 24675.876620616782, 25797.226083217534, 26394.208173754818, 26671.86664066667, 26696.866515667298, 40775.38836917508, 41156.79421602993, 41455.0, 41627.1674566513, 41695.374569380874, 205168.0, 205303.0, 205909.0, 206204.0, 206870.0, 22892.313230603108, 23907.880460597586, 24029.639555407033, 24953.0, 25115.246542603752, 35177.64822351744, 35209.47185792266, 35233.647663523036, 35448.29103417969, 36172.638273616925, 30850.382992340477, 31038.22404439907, 31073.8446307767, 31089.212392683836, 31589.210269743442, 30217.848910755307, 30585.54121688132, 31201.219969500944, 31676.0, 31676.683233167372, 30759.538606920465, 30935.226619334695, 31013.8449307752, 31878.840605796824, 34253.31493370169, 26373.64834802236, 27927.720722792514, 28647.140585781624, 29052.27369315784, 29280.121596352143, 22236.0, 22556.66165007559, 22793.31620051401, 23062.654060188775, 23091.19180828663], "value": 16547.228094999267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.749912556838, 384.9422586612006, 393.94878665773456, 397.28885295321373, 417.38019041723055, 17193.828061719378, 17432.73850892236, 17748.733768993443, 18180.727289090675, 18258.54353641158, 11194.38430886301, 11258.099352051817, 11444.313341199533, 11621.418929053534, 11655.242409243394, 4753.738544380067, 4930.4083509978855, 4938.234573641092, 4943.431505376874, 4949.059678661043, 4701.764911754416, 4826.155422801014, 4829.806807727687, 4847.51524847516, 4888.682235654689, 4833.661643684944, 4843.152448321547, 4848.612111031127, 4856.0, 4884.853454396356, 4862.2220444728855, 4880.414350277972, 4885.316055752198, 5236.738163091868, 5480.177973304037, 5350.411454739976, 5396.136618141118, 5397.8380648580605, 5402.243685883979, 5405.081136206854, 12921.547745828851, 17494.562635934075, 19314.13086411115, 21837.344879653636, 22222.333330000125, 2151.526664133888, 2186.8797216153107, 2196.7254093238344, 2201.933941981743, 2205.3273751505944, 9011.414258073204, 9461.574229159703, 9784.608615655365, 9795.266530442206, 9887.209023278121, 1697.6010637500178, 1697.9745303820453, 1734.4363081998401, 1753.3074435597866, 1767.0, 74393.62803186003, 78020.21979780187, 78323.0, 79112.0, 79693.60153199255, 10487.632932847313, 10571.15430765537, 10920.235583509237, 10928.0, 11125.276857004268, 15370.0, 15381.923090384476, 15409.768853467207, 15428.614284642974, 15443.227838608025, 6683.2648408675, 6808.080909077211, 6828.795136145924, 6975.197852246955, 7036.050133232051, 6104.511639068864, 6199.907001394983, 6345.777897773556, 6358.141650877073, 6363.809085727436, 4623.0, 4638.234691275969, 4748.7863046163, 4756.6908150970075, 4899.265110233494, 1964.3321270768008, 2005.428452890919, 2008.3874418302557, 2040.0, 2051.466618679154, 773.3272053313653, 801.210807354755, 806.0971711682953, 807.8868958345836, 816.4407380944073, 17353.392631257844, 17369.652606948042, 18134.727979080326, 18249.817501825077, 18644.81355186458, 791.192983157188, 795.6459375577928, 799.1648727080216, 805.8025783682918, 830.9002919649681, 9642.662506812228, 9734.75663108428, 9887.505624718735, 10076.59693612262, 10203.38779673222, 439158.0, 472422.0, 478447.58628964744, 485281.0, 486351.0, 70364.0, 70437.64781176062, 78010.60994695104, 87837.56081219681, 92180.0, 933.7012156110115, 978.6134476881734, 981.097390400833, 983.0660872171466, 984.9704508864745, 16072.696010316802, 16160.757588635945, 16509.83490165083, 16768.748468772734, 16821.158942053095, 35256.64743352534, 39505.209895802494, 40310.39534406928, 40823.1835363297, 42197.15605687931, 55757.0, 56314.718426407606, 56504.434955649915, 56660.71669641625, 57678.0, 7940.404469664682, 8014.0383154019555, 8111.513309201467, 8140.145284745016, 8231.670733170606, 10210.693679189637, 12311.753764924471, 12574.622761317176, 12631.536850314467, 12679.556215532411, 9861.506924653882, 10187.643432479828, 10498.0, 10561.788764224519, 10595.470226488798, 10435.530401131815, 10845.837312440477, 11039.392833393918, 11115.666530004113, 11443.25618834773, 10088.69733907984, 10266.845997310196, 10276.897231027595, 10337.431441270803, 10342.120919721607, 7586.468947173645, 7717.845643087219, 7847.411444141598, 8120.350371970347, 8340.499570025819, 5340.732963351895, 9099.31755118382, 9153.359264851397, 9996.800063998824, 10074.042965918226], "value": 8280.4084469403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.4831439895638, 1357.4095268558176, 1363.5704753002803, 1366.781314989602, 1373.9244341561214, 7283.526570772896, 7484.363829074521, 7730.536167829934, 7733.11069227039, 7751.457397982143, 7670.501417407864, 7788.922110778891, 7807.609619519029, 7814.101378341493, 7830.686772529092, 2120.713703650003, 2145.7639659637507, 2149.795769401904, 2159.125554150564, 2165.815905648014, 2129.882856442895, 2150.3226483657677, 2151.4621344663833, 2159.524904521003, 2162.027087810484, 2058.50595856994, 2068.855180137391, 2069.14130635786, 2087.060822629815, 2090.634139025672, 2115.566308906678, 2128.733908261467, 2131.2434085899513, 2149.12960251097, 2164.4047886831167, 1795.3985414886029, 1865.9533511662182, 1998.850086243523, 2017.515796208914, 2073.3365323096614, 7737.264959828807, 7756.224377562255, 7794.181610930884, 7808.453408261424, 7812.179721129313, 4383.736975781463, 4501.189785838547, 4510.075434535945, 4529.0715403342565, 4541.227991241464, 2925.224815423914, 2942.1173647905757, 2973.44991176633, 3015.411994661042, 3015.909522714322, 1082.1775450657478, 1085.8642669666292, 1092.421016861057, 1115.5370521233679, 1129.4239937631867, 10322.122619577345, 10333.638322658746, 10376.63681771142, 10412.479376031244, 10414.583416663325, 3865.845366185321, 3986.063275130342, 4036.4348991141264, 4061.5532291447917, 4133.338665813455, 8273.131321211185, 8301.252887240178, 8321.916780832235, 8333.708320208763, 8347.833043339098, 4590.9540904591195, 4626.306054091913, 4637.443506779208, 4648.697834640738, 4664.976675116603, 4100.425940368351, 4110.630043296118, 4189.973456503176, 4201.810918508674, 4239.872803815891, 3258.332041931446, 3314.784539004957, 3374.4769560718128, 3402.863885444604, 3406.42090844557, 1026.9435181064964, 1045.3414348960107, 1048.6958781953301, 1063.0485715284776, 1063.8351055586397, 769.992300076992, 798.1778767869104, 798.8641930871765, 802.6107337941094, 812.3582369927809, 5092.0, 5222.947770522246, 5242.842714718565, 5277.1292736698015, 5310.707911064928, 547.2311402479522, 547.2475346398702, 561.1890817768285, 574.6925394913785, 576.9596128270981, 3500.3524347995703, 3546.13119785649, 3546.2730140321173, 3604.945925811115, 3618.6924111450294, 8451.788705282293, 8616.0, 8994.0, 9015.098490151064, 9073.0, 8885.511296878734, 9006.954965225132, 9017.458952462874, 9163.129502697233, 9264.768380790534, 6723.327667233335, 6919.8962015569805, 6926.515143939876, 6935.0, 6938.722451101899, 4935.605151587936, 4961.50384961501, 5039.294498770102, 5118.129917913889, 5194.168932970707, 7832.84334313322, 8192.303654189222, 8419.579021049045, 8442.746717598482, 8445.1977062179, 8418.074011858569, 8477.74566762998, 8517.466855965986, 8622.396432249683, 8666.826663466569, 6896.965515172392, 6997.475189360716, 7052.259512751292, 7052.682629281592, 7055.753048643272, 7096.574205547684, 7163.140423149255, 7199.1361036675935, 7248.855022899618, 7257.818554535967, 6369.777057802955, 6544.934550654623, 6567.802965911031, 6657.833554161185, 6691.230508491586, 6315.96842015787, 6426.228852537539, 6454.967725161344, 6476.643784591893, 6483.124778154889, 5774.509166720875, 5791.218185544897, 5793.913091303718, 5802.187693722966, 5955.076963070731, 4456.710313829591, 4542.136993971135, 4580.267157254823, 4620.5379462053525, 4659.860204193879, 4474.642028637766, 4550.863474095782, 4696.0, 4706.129366067288, 4805.8558243252755], "value": 3974.589633383211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7372107779704, 363.02708740575247, 364.89965259553617, 366.6095608177291, 368.52092280035964, 5023.5981121510285, 5069.44236134025, 5070.75766437223, 5072.771725272362, 5074.644774865761, 4952.826651067214, 4986.35177426934, 4987.728129327016, 4992.900141997158, 5018.397792264934, 3769.1707824278683, 3902.7072969527258, 3933.2330195611867, 3940.9014774630577, 3951.451313902531, 3902.0635047588657, 3909.257241124177, 3916.9608303917025, 3924.62716041977, 3949.782761948092, 3913.256481268564, 3918.8824335269987, 3924.2151569686034, 3926.725129240954, 3933.6656384207377, 3661.5972243053243, 3825.5600605930395, 3898.8440462381473, 3918.373060310365, 3921.2157568486273, 3365.9663403366144, 3382.8308584570673, 3382.8646854125805, 3384.0, 3400.605751641815, 4817.795551112222, 4840.661153719241, 4874.951250487521, 4886.021161429627, 4949.604031677457, 4397.208502469554, 4419.801108950105, 4431.955680443219, 4454.8886277842985, 4466.53101424349, 5032.572231360339, 5193.376794784613, 5229.633925625208, 5230.92153617696, 5268.4994925482015, 3717.9070523237137, 3733.4773131761303, 3734.6265373462707, 3772.358699021173, 3788.6969042476535, 5257.789688412459, 5418.322709661293, 5520.834374968757, 5539.75639865855, 5542.362628297717, 3695.1685870678884, 3790.507234059555, 3791.7914514701956, 3801.125741079567, 3816.2254551633623, 3855.20968201518, 3864.415589608247, 3867.825947832298, 3902.843886244518, 3917.745346552465, 4401.933970990438, 4426.291793313118, 4432.002799370181, 4435.467743870756, 4439.733615983051, 5077.923831142536, 5217.530422262014, 5233.476652334736, 5264.736763161826, 5268.868278292996, 1286.311823174597, 1305.2364366845502, 1309.8755618216255, 1310.600266918599, 1313.6059182245288, 847.8050048488882, 898.9460632362079, 902.2421166220275, 913.6254135804288, 916.9684105381446, 4432.49026361966, 4434.268345722984, 4438.291257865745, 4447.0, 4470.932936005963, 5252.816151434758, 5287.769784172647, 5297.841064768063, 5298.682079075268, 5323.893522129613, 4309.224339618836, 4452.4211852458975, 4473.753943533137, 4489.775511224426, 4515.300128480025, 2754.5868119781794, 2788.860556972184, 2792.2181789098677, 2795.3710415156834, 2802.621646077794, 4862.80548778052, 4890.388701412324, 4894.19245824435, 4897.681650692693, 4905.681130726492, 5007.349044624176, 5301.416844147141, 5315.202719592092, 5371.704556249444, 5375.892482150335, 4844.4186697596515, 4871.537203965689, 4877.585405240594, 4908.533689299511, 4911.0, 5274.624240486015, 5275.575594589516, 5281.0, 5292.894142117213, 5294.417614062527, 4886.780094895667, 5207.3751149862255, 5228.320318358589, 5238.68567885928, 5269.552088072403, 4878.000049948689, 4898.8775280618265, 4901.534354236342, 4914.8053765053, 5014.7994080236385, 3821.178446633987, 3827.578966313759, 3835.558910725302, 3839.865604703822, 3854.730168888263, 5432.239486471818, 5433.864153396039, 5438.721900353335, 5438.864028399322, 5444.945550544444, 4962.826301079445, 5215.478452154754, 5268.947310526999, 5301.3373328333955, 5303.257543943928, 5174.689518628894, 5176.559992400537, 5220.676798824638, 5241.0, 5251.816186433456, 5195.3246078009615, 5201.349831271091, 5216.608754343363, 5226.45122262157, 5246.291750613618, 5009.198528235464, 5223.399309079353, 5249.501297376743, 5250.2912106866615, 5279.287296214962, 5118.232265160255, 5152.76812543444, 5155.716435596079, 5177.741112944413, 5187.429382767968], "value": 3932.0996113358938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.0596867370022, 688.6074937285746, 718.9928100718992, 721.4336745654659, 749.2994050562722, 12171.087168462367, 13063.804042939364, 13095.345232738373, 13113.934430327836, 13194.406251718672, 12661.24032558045, 12814.551490697828, 12874.549390771324, 12888.935555322234, 12952.287624180666, 782.7847341980959, 790.644210105452, 814.5235037503068, 815.2662603656727, 826.4297634632114, 819.2503858969036, 823.3948048184579, 823.9176082391742, 826.3017750001239, 828.3828547731918, 861.1947828780079, 862.7153039496982, 864.0668078475263, 866.384866744609, 868.847951608466, 859.5788063848669, 861.5046348349692, 861.7457849934284, 861.7630151708299, 862.7584276402617, 622.4366947912147, 625.0655270370825, 626.2297374229678, 626.8307556959641, 627.9277883043463, 12649.810252846215, 13027.478900843955, 13712.862871371259, 13733.0, 13746.243956582384, 11528.711782205428, 11692.356920369377, 11716.648500544912, 11917.642470725892, 11987.820182697267, 10246.129079028291, 10250.231232657581, 10444.216683748673, 10486.9475652622, 10533.736656583571, 3177.7140057394713, 3204.247001954539, 3218.662040485762, 3235.126515840733, 3238.044776790852, 56525.152122718195, 56810.999999999585, 57294.71352643252, 57334.42665573374, 57532.42467575312, 9672.661456848977, 9740.610375585038, 9845.458499782437, 9907.653232136985, 9925.404475731479, 17679.20443580042, 18307.816921830876, 18578.721319180222, 18723.81276187248, 19418.61162776765, 6392.26488953767, 6476.967615161894, 6518.445932095825, 6541.92058310383, 6687.899681504781, 3295.967040329566, 3378.3918894598714, 3390.2710917152435, 3417.333619944137, 3465.1510379956567, 3101.7673674474504, 3166.1609673436556, 3177.602799650044, 3177.8411079445937, 3213.7268332192025, 542.378976072395, 547.3650565344182, 556.4824713016852, 561.7472137538124, 563.132775525694, 641.3650486018807, 659.9406053455212, 668.6021817018866, 677.2009029345321, 688.9552179108342, 8888.733337999742, 9263.212626926786, 9312.953435232781, 9343.95025064037, 9345.859812102824, 526.7866514061811, 530.0856023359673, 554.8862483190936, 674.2448457727377, 684.6474065856088, 3736.9065773355883, 4094.7952602369764, 4212.199682060399, 4241.2365774160335, 4583.931241031387, 58065.129023064685, 59433.405665943654, 60430.39569604336, 60482.697586512666, 62790.68604656948, 52638.21042684363, 52893.0, 53203.73398133062, 53763.19355209675, 54612.453875460735, 40137.799311003255, 40712.0, 41797.1640567193, 48283.517164828605, 48294.0, 9332.113449222314, 9663.710088697351, 9694.56374463165, 9823.36148150368, 9839.557219925264, 33437.16407089842, 33561.49657755184, 33769.662303377634, 33836.0, 34287.48568771421, 40636.390454142624, 41170.38244426276, 41801.0, 42959.355609666505, 43751.0, 11281.492332844877, 11317.943410282896, 11318.32090074598, 11567.132465064986, 11809.0, 11814.173007889365, 11884.821727674265, 12279.570215042431, 12389.194702344319, 12788.936055319664, 11778.941105294418, 11873.82189267179, 12075.0, 12229.266244025386, 12606.87393126057, 11867.525298987945, 11938.880611193777, 12448.564300249811, 12494.437750301076, 12548.244328652521, 11257.268277561932, 11905.107116966436, 12007.099467540143, 12231.0, 12279.0, 8777.85883368813, 9192.816143677222, 9231.215346695606, 9435.669751558662, 9510.334276600572, 9034.683000556899, 9347.906520934976, 9844.114029737359, 10274.537645806106, 10404.0], "value": 6275.575054356249, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 116.0, 117.0, 115.0, 117.0, 116.0, 116.0, 114.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 132.0, 175.0, 128.0, 126.0, 125.0, 127.0, 152.0, 126.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 168.0, 170.0, 166.0, 162.0, 163.0, 163.0, 162.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 117.0, 77.0, 77.0, 77.0, 78.0, 96.0, 78.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 86.0, 88.0, 89.0, 98.0, 85.0, 85.0, 110.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 121.0, 117.0, 119.0, 121.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 150.0, 155.0, 151.0, 151.0, 151.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 65.0, 69.0, 67.0, 66.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 86.0, 86.0, 89.0, 86.0, 86.0, 91.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 136.0, 140.0, 133.0, 143.0, 137.0, 141.0, 203.0, 132.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 176.0, 183.0, 176.0, 179.0, 179.0, 177.0, 181.0, 181.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 69.0, 69.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 68.7, "unit": "score"}]}]} 17:56:49 INFO - Return code: 0 17:56:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:56:49 ERROR - # TBPL SUCCESS # 17:56:49 INFO - Running post-action listener: _resource_record_post_action 17:56:49 INFO - [mozharness: 2017-02-04 01:56:49.627542Z] Finished run-tests step (success) 17:56:49 INFO - Running post-run listener: _resource_record_post_run 17:56:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 397942784; Read time: 20; Write time: 254684 17:56:49 INFO - TinderboxPrint: CPU usage
13.4% 17:56:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 17:56:49 INFO - TinderboxPrint: I/O write bytes / time
397,942,784 / 254,684 17:56:49 INFO - TinderboxPrint: CPU idle
8,302.4 (86.6%) 17:56:49 INFO - TinderboxPrint: CPU user
1,232.8 (12.9%) 17:56:49 INFO - TinderboxPrint: Swap in / out
0 / 0 17:56:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99622912; Read time: 0; Write time: 67060 17:56:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298319872; Read time: 8; Write time: 187624 17:56:50 INFO - Running post-run listener: _upload_blobber_files 17:56:50 INFO - Blob upload gear active. 17:56:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:50 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 17:56:50 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'] 17:56:50 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 17:56:50 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:51 INFO - (blobuploader) - INFO - Done attempting. 17:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:52 INFO - (blobuploader) - INFO - Done attempting. 17:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:55 INFO - (blobuploader) - INFO - Done attempting. 17:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:56 INFO - (blobuploader) - INFO - Done attempting. 17:56:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:56 INFO - Return code: 0 17:56:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21a2181672603639d6d3da3ef2625b8c30586ea50a2e943acfcd5992dfbf278f8fbe50e934275fc37b99be23483a338e50b208dd45bf45c3bf284cc4e0ca05d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2951eaade679f594a3b5f0ea55e51683272bb81f608fcc4bfebb6c0d6f2977ff36e35f6019e41ae3ea4b9bfe52c76c56b2983679403c658db23dc76f2c1946be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c15c2476b472f51729a8eb41ebeeaab7e906676262f63fa73fe861e2927e8854ba938b96daae8fe948e50efb351b210ba2b1fc28000c96503b05283d6aacc48e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366c5df39104fe5aaaa648050f3310ed0d8926fa285986e1eb928a8c247ac0f50c5c9be910973a5a4f655597ae09dec1812e3edfe76293a664e740e58fa96a6f"} 17:56:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:56 INFO - Contents: 17:56:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21a2181672603639d6d3da3ef2625b8c30586ea50a2e943acfcd5992dfbf278f8fbe50e934275fc37b99be23483a338e50b208dd45bf45c3bf284cc4e0ca05d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2951eaade679f594a3b5f0ea55e51683272bb81f608fcc4bfebb6c0d6f2977ff36e35f6019e41ae3ea4b9bfe52c76c56b2983679403c658db23dc76f2c1946be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c15c2476b472f51729a8eb41ebeeaab7e906676262f63fa73fe861e2927e8854ba938b96daae8fe948e50efb351b210ba2b1fc28000c96503b05283d6aacc48e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366c5df39104fe5aaaa648050f3310ed0d8926fa285986e1eb928a8c247ac0f50c5c9be910973a5a4f655597ae09dec1812e3edfe76293a664e740e58fa96a6f"} 17:56:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:56 INFO - Copying logs to upload dir... 17:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.458093 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-02-03 17:56:56.800001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 17:56:56.803948) ========= 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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 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/21a2181672603639d6d3da3ef2625b8c30586ea50a2e943acfcd5992dfbf278f8fbe50e934275fc37b99be23483a338e50b208dd45bf45c3bf284cc4e0ca05d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2951eaade679f594a3b5f0ea55e51683272bb81f608fcc4bfebb6c0d6f2977ff36e35f6019e41ae3ea4b9bfe52c76c56b2983679403c658db23dc76f2c1946be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c15c2476b472f51729a8eb41ebeeaab7e906676262f63fa73fe861e2927e8854ba938b96daae8fe948e50efb351b210ba2b1fc28000c96503b05283d6aacc48e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366c5df39104fe5aaaa648050f3310ed0d8926fa285986e1eb928a8c247ac0f50c5c9be910973a5a4f655597ae09dec1812e3edfe76293a664e740e58fa96a6f"} build_url:https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/WxR2bgBpRfybZxMw7l3iyg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21a2181672603639d6d3da3ef2625b8c30586ea50a2e943acfcd5992dfbf278f8fbe50e934275fc37b99be23483a338e50b208dd45bf45c3bf284cc4e0ca05d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2951eaade679f594a3b5f0ea55e51683272bb81f608fcc4bfebb6c0d6f2977ff36e35f6019e41ae3ea4b9bfe52c76c56b2983679403c658db23dc76f2c1946be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c15c2476b472f51729a8eb41ebeeaab7e906676262f63fa73fe861e2927e8854ba938b96daae8fe948e50efb351b210ba2b1fc28000c96503b05283d6aacc48e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/366c5df39104fe5aaaa648050f3310ed0d8926fa285986e1eb928a8c247ac0f50c5c9be910973a5a4f655597ae09dec1812e3edfe76293a664e740e58fa96a6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 17:56:56.831001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:56:56.831507) ========= 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=62c568580acbfdaac3eec7be000001dc-1486172166.667992-2065174849 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 17:56:56.915109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 17:56:56.915620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 17:56:56.916123) ========= ========= Total master_lag: 0.17 =========