builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1490796909.55 results: success (0) revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.554078) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.554543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.554874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.570137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.570528) ========= 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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 07:15:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-03-29 07:15:09 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.706657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.706962) ========= 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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:09.755907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-29 07:15:09.756242) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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 c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 07:15:09,884 truncating revision to first 12 chars 2017-03-29 07:15:09,884 Setting DEBUG logging. 2017-03-29 07:15:09,884 attempt 1/10 2017-03-29 07:15:09,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4392f466eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 07:15:13,298 unpacking tar archive at: mozilla-central-c4392f466eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=3.717154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-29 07:15:13.486635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:13.486949) ========= script_repo_revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:13.487334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:13.487596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:15:13.495992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-29 07:15:13.496298) ========= /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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:13 INFO - MultiFileLogger online at 20170329 07:15:13 in /builds/slave/test 07:15:13 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 07:15:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:13 INFO - {'append_to_log': False, 07:15:13 INFO - 'base_work_dir': '/builds/slave/test', 07:15:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:15:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:13 INFO - 'branch': 'Firefox-Non-PGO', 07:15:13 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:13 INFO - 'config_files': ('talos/linux_config.py',), 07:15:13 INFO - 'default_actions': ('clobber', 07:15:13 INFO - 'read-buildbot-config', 07:15:13 INFO - 'download-and-extract', 07:15:13 INFO - 'populate-webroot', 07:15:13 INFO - 'create-virtualenv', 07:15:13 INFO - 'install', 07:15:13 INFO - 'run-tests'), 07:15:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:13 INFO - 'download_minidump_stackwalk': True, 07:15:13 INFO - 'download_symbols': 'ondemand', 07:15:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:13 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:13 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:13 INFO - 'gecko_profile': False, 07:15:13 INFO - 'gecko_profile_interval': 0, 07:15:13 INFO - 'installer_path': 'installer.exe', 07:15:13 INFO - 'log_level': 'info', 07:15:13 INFO - 'log_name': 'talos', 07:15:13 INFO - 'log_to_console': True, 07:15:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:13 INFO - 'opt_config_files': (), 07:15:13 INFO - 'pip_index': False, 07:15:13 INFO - 'suite': 'dromaeojs-e10s', 07:15:13 INFO - 'system_bits': '32', 07:15:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:13 INFO - 'title': 'talos-linux64-ix-010', 07:15:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:13 INFO - 'use_talos_json': True, 07:15:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:13 INFO - 'work_dir': 'build'} 07:15:13 INFO - [mozharness: 2017-03-29 14:15:13.717656Z] Running clobber step. 07:15:13 INFO - Running pre-action listener: _resource_record_pre_action 07:15:13 INFO - Running main action method: clobber 07:15:13 INFO - rmtree: /builds/slave/test/build 07:15:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:14 INFO - Running post-action listener: _resource_record_post_action 07:15:14 INFO - [mozharness: 2017-03-29 14:15:14.650609Z] Finished clobber step (success) 07:15:14 INFO - [mozharness: 2017-03-29 14:15:14.650712Z] Running read-buildbot-config step. 07:15:14 INFO - Running pre-action listener: _resource_record_pre_action 07:15:14 INFO - Running main action method: read_buildbot_config 07:15:14 INFO - Using buildbot properties: 07:15:14 INFO - { 07:15:14 INFO - "project": "", 07:15:14 INFO - "product": "firefox", 07:15:14 INFO - "who": "ryanvm@gmail.com", 07:15:14 INFO - "installer_path": "public/build/target.tar.bz2", 07:15:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:15:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:15:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:15:14 INFO - "stage_platform": "linux64", 07:15:14 INFO - "basedir": "/builds/slave/test", 07:15:14 INFO - "buildnumber": 491, 07:15:14 INFO - "platform": "ubuntu64_hw", 07:15:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:15:14 INFO - "slavebuilddir": "test", 07:15:14 INFO - "taskId": "CtqxXegmTvyETNws4BT6yw", 07:15:14 INFO - "branch": "mozilla-central", 07:15:14 INFO - "script_repo_revision": "production", 07:15:14 INFO - "revision": "c4392f466eaab690d9b0ef7bacf72fa5e6573007", 07:15:14 INFO - "slavename": "talos-linux64-ix-010", 07:15:14 INFO - "repo_path": "mozilla-central" 07:15:14 INFO - } 07:15:14 INFO - Finding installer, test and symbols from parent task. 07:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CtqxXegmTvyETNws4BT6yw'}, attempt #1 07:15:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CtqxXegmTvyETNws4BT6yw'}, attempt #1 07:15:15 INFO - Task dependencies: Lizx6zgGT2iHJFELVUoVlg 07:15:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg'}, attempt #1 07:15:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/test_packages.json 07:15:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip 07:15:16 INFO - Running post-action listener: _resource_record_post_action 07:15:16 INFO - [mozharness: 2017-03-29 14:15:16.052908Z] Finished read-buildbot-config step (success) 07:15:16 INFO - [mozharness: 2017-03-29 14:15:16.053125Z] Running download-and-extract step. 07:15:16 INFO - Running pre-action listener: _resource_record_pre_action 07:15:16 INFO - Running main action method: download_and_extract 07:15:16 INFO - mkdir: /builds/slave/test/build/tests 07:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:16 INFO - trying https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json 07:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:15:16 INFO - Downloaded 986 bytes. 07:15:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:15:16 INFO - Using the following test package requirements: 07:15:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:15:16 INFO - u'common': [u'target.common.tests.zip'], 07:15:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:15:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:15:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:15:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:15:16 INFO - u'mozbase': [u'target.common.tests.zip'], 07:15:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:15:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:15:16 INFO - u'web-platform': [u'target.common.tests.zip', 07:15:16 INFO - u'target.web-platform.tests.zip'], 07:15:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:15:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:15:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip 07:15:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip into memory 07:15:17 INFO - Expected file size: 58223762 07:15:17 INFO - Obtained file size: 58223762 07:15:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:15:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip 07:15:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip into memory 07:15:28 INFO - Expected file size: 58223762 07:15:28 INFO - Obtained file size: 58223762 07:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip 07:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip into memory 07:15:40 INFO - Expected file size: 14404171 07:15:40 INFO - Obtained file size: 14404171 07:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:40 INFO - trying https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:15:41 INFO - Downloaded 62581144 bytes. 07:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:41 INFO - mkdir: /builds/slave/test/properties 07:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:41 INFO - Contents: 07:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:41 INFO - Running post-action listener: _resource_record_post_action 07:15:41 INFO - Running post-action listener: set_extra_try_arguments 07:15:41 INFO - [mozharness: 2017-03-29 14:15:41.448887Z] Finished download-and-extract step (success) 07:15:41 INFO - [mozharness: 2017-03-29 14:15:41.448983Z] Running populate-webroot step. 07:15:41 INFO - Running pre-action listener: _resource_record_pre_action 07:15:41 INFO - Running main action method: populate_webroot 07:15:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:41 INFO - '--tppagecycles', 07:15:41 INFO - '7'], 07:15:41 INFO - 'tests': ['tsvgm']}}, 07:15:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['damp', 'tps']}, 07:15:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'tests': ['damp', 'tps']}, 07:15:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['dromaeo_dom']}, 07:15:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['basic_compositor_video']}, 07:15:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['a11yr', 07:15:41 INFO - 'ts_paint', 07:15:41 INFO - 'tpaint', 07:15:41 INFO - 'sessionrestore', 07:15:41 INFO - 'sessionrestore_no_auto_restore', 07:15:41 INFO - 'tabpaint']}, 07:15:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['tsvgx', 07:15:41 INFO - 'tsvgr_opacity', 07:15:41 INFO - 'tart', 07:15:41 INFO - 'tscrollx', 07:15:41 INFO - 'cart', 07:15:41 INFO - 'tsvg_static']}, 07:15:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:41 INFO - 'tsvgr_opacity', 07:15:41 INFO - 'tart', 07:15:41 INFO - 'tscrollx', 07:15:41 INFO - 'cart', 07:15:41 INFO - 'tsvg_static']}, 07:15:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'talos_options': ['--disable-e10s'], 07:15:41 INFO - 'tests': ['tp5o']}, 07:15:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:15:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'talos_options': ['--disable-e10s', 07:15:41 INFO - '--xperf_path', 07:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:41 INFO - 'tests': ['tp5n']}, 07:15:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:15:41 INFO - 'talos_options': ['--xperf_path', 07:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:41 INFO - 'tests': ['tp5n']}}, 07:15:41 INFO - 'talos.zip': {'path': '', 07:15:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:41 INFO - Running post-action listener: _resource_record_post_action 07:15:41 INFO - [mozharness: 2017-03-29 14:15:41.462137Z] Finished populate-webroot step (success) 07:15:41 INFO - [mozharness: 2017-03-29 14:15:41.462226Z] Running create-virtualenv step. 07:15:41 INFO - Running pre-action listener: _resource_record_pre_action 07:15:41 INFO - Running main action method: create_virtualenv 07:15:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:41 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 07:15:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:41 INFO - Using real prefix '/usr' 07:15:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:44 INFO - Installing pip.................done. 07:15:44 INFO - Return code: 0 07:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:15:44 INFO - Reading from file tmpfile_stdout 07:15:44 INFO - Output received: 07:15:44 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) 07:15:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:44 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')]} 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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')]} 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:44 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 07:15:44 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 07:15:44 INFO - Using env: {'DISPLAY': ':0', 07:15:44 INFO - 'HOME': '/home/cltbld', 07:15:44 INFO - 'LANG': 'en_US.UTF-8', 07:15:44 INFO - 'LANGUAGE': 'en_US:en', 07:15:44 INFO - 'LOGNAME': 'cltbld', 07:15:44 INFO - 'MAIL': '/var/mail/cltbld', 07:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:44 INFO - 'MOZ_NO_REMOTE': '1', 07:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:44 INFO - 'NO_EM_RESTART': '1', 07:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:44 INFO - 'PWD': '/builds/slave/test', 07:15:44 INFO - 'SHELL': '/bin/bash', 07:15:44 INFO - 'SHLVL': '1', 07:15:44 INFO - 'TERM': 'linux', 07:15:44 INFO - 'TMOUT': '86400', 07:15:44 INFO - 'USER': 'cltbld', 07:15:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:44 INFO - '_': '/tools/buildbot/bin/python'} 07:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:44 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 07:15:44 INFO - Cleaning up... 07:15:44 INFO - Return code: 0 07:15:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:44 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')]} 07:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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')]} 07:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:44 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:44 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 07:15:44 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 07:15:44 INFO - Using env: {'DISPLAY': ':0', 07:15:44 INFO - 'HOME': '/home/cltbld', 07:15:44 INFO - 'LANG': 'en_US.UTF-8', 07:15:44 INFO - 'LANGUAGE': 'en_US:en', 07:15:44 INFO - 'LOGNAME': 'cltbld', 07:15:44 INFO - 'MAIL': '/var/mail/cltbld', 07:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:44 INFO - 'MOZ_NO_REMOTE': '1', 07:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:44 INFO - 'NO_EM_RESTART': '1', 07:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:44 INFO - 'PWD': '/builds/slave/test', 07:15:44 INFO - 'SHELL': '/bin/bash', 07:15:44 INFO - 'SHLVL': '1', 07:15:44 INFO - 'TERM': 'linux', 07:15:44 INFO - 'TMOUT': '86400', 07:15:44 INFO - 'USER': 'cltbld', 07:15:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:44 INFO - '_': '/tools/buildbot/bin/python'} 07:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:44 INFO - Downloading/unpacking psutil>=3.1.1 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:46 INFO - Installing collected packages: psutil 07:15:46 INFO - Running setup.py install for psutil 07:15:46 INFO - building 'psutil._psutil_linux' extension 07:15:46 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 07:15:47 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 07:15:47 INFO - building 'psutil._psutil_posix' extension 07:15:47 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 07:15:47 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 07:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:47 INFO - Successfully installed psutil 07:15:47 INFO - Cleaning up... 07:15:47 INFO - Return code: 0 07:15:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:15: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 mozsystemmonitor==0.3 07:15:47 INFO - Using env: {'DISPLAY': ':0', 07:15:47 INFO - 'HOME': '/home/cltbld', 07:15:47 INFO - 'LANG': 'en_US.UTF-8', 07:15:47 INFO - 'LANGUAGE': 'en_US:en', 07:15:47 INFO - 'LOGNAME': 'cltbld', 07:15:47 INFO - 'MAIL': '/var/mail/cltbld', 07:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:47 INFO - 'MOZ_NO_REMOTE': '1', 07:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:47 INFO - 'NO_EM_RESTART': '1', 07:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:47 INFO - 'PWD': '/builds/slave/test', 07:15:47 INFO - 'SHELL': '/bin/bash', 07:15:47 INFO - 'SHLVL': '1', 07:15:47 INFO - 'TERM': 'linux', 07:15:47 INFO - 'TMOUT': '86400', 07:15:47 INFO - 'USER': 'cltbld', 07:15:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:47 INFO - '_': '/tools/buildbot/bin/python'} 07:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:50 INFO - Installing collected packages: mozsystemmonitor 07:15:50 INFO - Running setup.py install for mozsystemmonitor 07:15:50 INFO - Successfully installed mozsystemmonitor 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:51 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:51 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 07:15:51 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 07:15:51 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 07:15:51 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 07:15:51 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 07:15:51 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 07:15:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:53 INFO - warning: no files found matching '*.txt' 07:15:53 INFO - no previously-included directories found matching 'build' 07:15:53 INFO - no previously-included directories found matching 'dist' 07:15:53 INFO - no previously-included directories found matching '.git*' 07:15:53 INFO - Installing collected packages: jsonschema, functools32 07:15:53 INFO - Running setup.py install for functools32 07:15:53 INFO - warning: no files found matching '*.txt' 07:15:53 INFO - no previously-included directories found matching 'build' 07:15:53 INFO - no previously-included directories found matching 'dist' 07:15:53 INFO - no previously-included directories found matching '.git*' 07:15:53 INFO - Successfully installed jsonschema functools32 07:15:53 INFO - Cleaning up... 07:15:53 INFO - Return code: 0 07:15:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:15:53 INFO - Using env: {'DISPLAY': ':0', 07:15:53 INFO - 'HOME': '/home/cltbld', 07:15:53 INFO - 'LANG': 'en_US.UTF-8', 07:15:53 INFO - 'LANGUAGE': 'en_US:en', 07:15:53 INFO - 'LOGNAME': 'cltbld', 07:15:53 INFO - 'MAIL': '/var/mail/cltbld', 07:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:53 INFO - 'MOZ_NO_REMOTE': '1', 07:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:53 INFO - 'NO_EM_RESTART': '1', 07:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:53 INFO - 'PWD': '/builds/slave/test', 07:15:53 INFO - 'SHELL': '/bin/bash', 07:15:53 INFO - 'SHLVL': '1', 07:15:53 INFO - 'TERM': 'linux', 07:15:53 INFO - 'TMOUT': '86400', 07:15:53 INFO - 'USER': 'cltbld', 07:15:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:53 INFO - '_': '/tools/buildbot/bin/python'} 07:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:15:53 INFO - Cleaning up... 07:15:53 INFO - Return code: 0 07:15:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:15:53 INFO - Using env: {'DISPLAY': ':0', 07:15:53 INFO - 'HOME': '/home/cltbld', 07:15:53 INFO - 'LANG': 'en_US.UTF-8', 07:15:53 INFO - 'LANGUAGE': 'en_US:en', 07:15:53 INFO - 'LOGNAME': 'cltbld', 07:15:53 INFO - 'MAIL': '/var/mail/cltbld', 07:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:53 INFO - 'MOZ_NO_REMOTE': '1', 07:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:53 INFO - 'NO_EM_RESTART': '1', 07:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:53 INFO - 'PWD': '/builds/slave/test', 07:15:53 INFO - 'SHELL': '/bin/bash', 07:15:53 INFO - 'SHLVL': '1', 07:15:53 INFO - 'TERM': 'linux', 07:15:53 INFO - 'TMOUT': '86400', 07:15:53 INFO - 'USER': 'cltbld', 07:15:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:53 INFO - '_': '/tools/buildbot/bin/python'} 07:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:56 INFO - Downloading docopt-0.6.1.tar.gz 07:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:56 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:56 INFO - Running setup.py install for blobuploader 07:15:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:56 INFO - Running setup.py install for requests 07:15:57 INFO - Running setup.py install for docopt 07:15:57 INFO - Successfully installed blobuploader requests docopt 07:15:57 INFO - Cleaning up... 07:15:57 INFO - Return code: 0 07:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:57 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')]} 07:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:57 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')]} 07:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:57 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:15:57 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 07:15:57 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 07:15:57 INFO - Using env: {'DISPLAY': ':0', 07:15:57 INFO - 'HOME': '/home/cltbld', 07:15:57 INFO - 'LANG': 'en_US.UTF-8', 07:15:57 INFO - 'LANGUAGE': 'en_US:en', 07:15:57 INFO - 'LOGNAME': 'cltbld', 07:15:57 INFO - 'MAIL': '/var/mail/cltbld', 07:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:57 INFO - 'MOZ_NO_REMOTE': '1', 07:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:57 INFO - 'NO_EM_RESTART': '1', 07:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:57 INFO - 'PWD': '/builds/slave/test', 07:15:57 INFO - 'SHELL': '/bin/bash', 07:15:57 INFO - 'SHLVL': '1', 07:15:57 INFO - 'TERM': 'linux', 07:15:57 INFO - 'TMOUT': '86400', 07:15:57 INFO - 'USER': 'cltbld', 07:15:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:57 INFO - '_': '/tools/buildbot/bin/python'} 07:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:57 INFO - Running setup.py (path:/tmp/pip-D8XisF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:57 INFO - Running setup.py (path:/tmp/pip-eXjwAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:57 INFO - Running setup.py (path:/tmp/pip-Wu9YQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:57 INFO - Running setup.py (path:/tmp/pip-d_mYoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:57 INFO - Running setup.py (path:/tmp/pip-HywF3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:57 INFO - Running setup.py (path:/tmp/pip-XunrLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:58 INFO - Running setup.py (path:/tmp/pip-5pYIo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:58 INFO - Running setup.py (path:/tmp/pip-Tc_Wpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:58 INFO - Running setup.py (path:/tmp/pip-aoUDm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:58 INFO - Running setup.py (path:/tmp/pip-gaT4qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:58 INFO - Running setup.py (path:/tmp/pip-TXNg3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:58 INFO - Running setup.py (path:/tmp/pip-5JdXSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:58 INFO - Running setup.py (path:/tmp/pip-YQEV7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:58 INFO - Running setup.py (path:/tmp/pip-Xn3IPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:58 INFO - Running setup.py (path:/tmp/pip-aFNRch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:58 INFO - Running setup.py (path:/tmp/pip-h4nN8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:58 INFO - Running setup.py (path:/tmp/pip-UsgE3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:58 INFO - Running setup.py install for manifestparser 07:15:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozcrash 07:15:59 INFO - Running setup.py install for mozdebug 07:15:59 INFO - Running setup.py install for mozdevice 07:15:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozfile 07:15:59 INFO - Running setup.py install for mozhttpd 07:15:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozinfo 07:15:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozInstall 07:15:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozleak 07:15:59 INFO - Running setup.py install for mozlog 07:15:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for moznetwork 07:15:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozprocess 07:16:00 INFO - Running setup.py install for mozprofile 07:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozrunner 07:16:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Running setup.py install for mozscreenshot 07:16:00 INFO - Running setup.py install for moztest 07:16:00 INFO - Running setup.py install for mozversion 07:16:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:00 INFO - Cleaning up... 07:16:00 INFO - Return code: 0 07:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:00 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')]} 07:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:00 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')]} 07:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:00 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:16:00 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 07:16:00 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 07:16:00 INFO - Using env: {'DISPLAY': ':0', 07:16:00 INFO - 'HOME': '/home/cltbld', 07:16:00 INFO - 'LANG': 'en_US.UTF-8', 07:16:00 INFO - 'LANGUAGE': 'en_US:en', 07:16:00 INFO - 'LOGNAME': 'cltbld', 07:16:00 INFO - 'MAIL': '/var/mail/cltbld', 07:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:00 INFO - 'MOZ_NO_REMOTE': '1', 07:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:00 INFO - 'NO_EM_RESTART': '1', 07:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:00 INFO - 'PWD': '/builds/slave/test', 07:16:00 INFO - 'SHELL': '/bin/bash', 07:16:00 INFO - 'SHLVL': '1', 07:16:00 INFO - 'TERM': 'linux', 07:16:00 INFO - 'TMOUT': '86400', 07:16:00 INFO - 'USER': 'cltbld', 07:16:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:00 INFO - '_': '/tools/buildbot/bin/python'} 07:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:00 INFO - Running setup.py (path:/tmp/pip-L7WIhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:00 INFO - Running setup.py (path:/tmp/pip-LWXreX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:00 INFO - Running setup.py (path:/tmp/pip-L99dNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:01 INFO - Running setup.py (path:/tmp/pip-eF1tt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:01 INFO - Running setup.py (path:/tmp/pip-iWtOUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:01 INFO - Running setup.py (path:/tmp/pip-NFCraj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:01 INFO - Running setup.py (path:/tmp/pip-1ryEvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:01 INFO - Running setup.py (path:/tmp/pip-ofj63u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:01 INFO - Running setup.py (path:/tmp/pip-9H5Nkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:01 INFO - Running setup.py (path:/tmp/pip-hfZcn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:01 INFO - Running setup.py (path:/tmp/pip-pLUrEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:01 INFO - Running setup.py (path:/tmp/pip-gtSbn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:01 INFO - Running setup.py (path:/tmp/pip-Kx3mNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:01 INFO - Running setup.py (path:/tmp/pip-XOOrQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:01 INFO - Running setup.py (path:/tmp/pip-FNWVMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:01 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)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:01 INFO - Running setup.py (path:/tmp/pip-yemYSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:02 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)) 07:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:02 INFO - Running setup.py (path:/tmp/pip-8y4cTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 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)) 07:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:02 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 07:16:04 INFO - Downloading blessings-1.6.tar.gz 07:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:04 INFO - Installing collected packages: blessings 07:16:04 INFO - Running setup.py install for blessings 07:16:04 INFO - Successfully installed blessings 07:16:04 INFO - Cleaning up... 07:16:04 INFO - Return code: 0 07:16:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:04 INFO - Reading from file tmpfile_stdout 07:16:04 INFO - Current package versions: 07:16:04 INFO - argparse == 1.2.1 07:16:04 INFO - blessings == 1.6 07:16:04 INFO - blobuploader == 1.2.4 07:16:04 INFO - docopt == 0.6.1 07:16:04 INFO - functools32 == 3.2.3-2 07:16:04 INFO - jsonschema == 2.5.1 07:16:04 INFO - manifestparser == 1.1 07:16:04 INFO - mozInstall == 1.12 07:16:04 INFO - mozcrash == 1.0 07:16:04 INFO - mozdebug == 0.1 07:16:04 INFO - mozdevice == 0.49 07:16:04 INFO - mozfile == 1.2 07:16:04 INFO - mozhttpd == 0.7 07:16:04 INFO - mozinfo == 0.9 07:16:04 INFO - mozleak == 0.1 07:16:04 INFO - mozlog == 3.4 07:16:04 INFO - moznetwork == 0.27 07:16:04 INFO - mozprocess == 0.25 07:16:04 INFO - mozprofile == 0.28 07:16:04 INFO - mozrunner == 6.13 07:16:04 INFO - mozscreenshot == 0.1 07:16:04 INFO - mozsystemmonitor == 0.3 07:16:04 INFO - moztest == 0.8 07:16:04 INFO - mozversion == 1.4 07:16:04 INFO - psutil == 3.1.1 07:16:04 INFO - requests == 1.2.3 07:16:04 INFO - wsgiref == 0.1.2 07:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16: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')]} 07:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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')]} 07:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:04 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:16:04 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 07:16:04 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 07:16:04 INFO - Using env: {'DISPLAY': ':0', 07:16:04 INFO - 'HOME': '/home/cltbld', 07:16:04 INFO - 'LANG': 'en_US.UTF-8', 07:16:04 INFO - 'LANGUAGE': 'en_US:en', 07:16:04 INFO - 'LOGNAME': 'cltbld', 07:16:04 INFO - 'MAIL': '/var/mail/cltbld', 07:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:04 INFO - 'MOZ_NO_REMOTE': '1', 07:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:04 INFO - 'NO_EM_RESTART': '1', 07:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:04 INFO - 'PWD': '/builds/slave/test', 07:16:04 INFO - 'SHELL': '/bin/bash', 07:16:04 INFO - 'SHLVL': '1', 07:16:04 INFO - 'TERM': 'linux', 07:16:04 INFO - 'TMOUT': '86400', 07:16:04 INFO - 'USER': 'cltbld', 07:16:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:04 INFO - '_': '/tools/buildbot/bin/python'} 07:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 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)) 07:16:04 INFO - Cleaning up... 07:16:04 INFO - Return code: 0 07:16:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16: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')]} 07:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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')]} 07:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:04 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 0x17eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, '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': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', '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 07:16:04 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 07:16:04 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 07:16:04 INFO - Using env: {'DISPLAY': ':0', 07:16:04 INFO - 'HOME': '/home/cltbld', 07:16:04 INFO - 'LANG': 'en_US.UTF-8', 07:16:04 INFO - 'LANGUAGE': 'en_US:en', 07:16:04 INFO - 'LOGNAME': 'cltbld', 07:16:04 INFO - 'MAIL': '/var/mail/cltbld', 07:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:04 INFO - 'MOZ_NO_REMOTE': '1', 07:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:04 INFO - 'NO_EM_RESTART': '1', 07:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:04 INFO - 'PWD': '/builds/slave/test', 07:16:04 INFO - 'SHELL': '/bin/bash', 07:16:04 INFO - 'SHLVL': '1', 07:16:04 INFO - 'TERM': 'linux', 07:16:04 INFO - 'TMOUT': '86400', 07:16:04 INFO - 'USER': 'cltbld', 07:16:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:04 INFO - '_': '/tools/buildbot/bin/python'} 07:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:16:05 INFO - Cleaning up... 07:16:05 INFO - Return code: 0 07:16:05 INFO - Running post-action listener: _resource_record_post_action 07:16:05 INFO - Running post-action listener: _start_resource_monitoring 07:16:05 INFO - Starting resource monitoring. 07:16:05 INFO - [mozharness: 2017-03-29 14:16:05.077951Z] Finished create-virtualenv step (success) 07:16:05 INFO - [mozharness: 2017-03-29 14:16:05.078427Z] Running install step. 07:16:05 INFO - Running pre-action listener: _resource_record_pre_action 07:16:05 INFO - Running main action method: install 07:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:05 INFO - Reading from file tmpfile_stdout 07:16:05 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:05 INFO - Reading from file tmpfile_stdout 07:16:05 INFO - Output received: 07:16:05 INFO - Usage: mozinstall [options] installer 07:16:05 INFO - Options: 07:16:05 INFO - -h, --help show this help message and exit 07:16:05 INFO - -d DEST, --destination=DEST 07:16:05 INFO - Directory to install application into. [default: 07:16:05 INFO - "/builds/slave/test"] 07:16:05 INFO - --app=APP Application being installed. [default: firefox] 07:16:05 INFO - mkdir: /builds/slave/test/build/application 07:16:05 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'] 07:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:16:21 INFO - Reading from file tmpfile_stdout 07:16:21 INFO - Output received: 07:16:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:21 INFO - Running post-action listener: _resource_record_post_action 07:16:21 INFO - [mozharness: 2017-03-29 14:16:21.021695Z] Finished install step (success) 07:16:21 INFO - [mozharness: 2017-03-29 14:16:21.021969Z] Running run-tests step. 07:16:21 INFO - Running pre-action listener: _resource_record_pre_action 07:16:21 INFO - Running main action method: run_tests 07:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:21 INFO - Python 2.7.3 07:16:21 INFO - Return code: 0 07:16:21 INFO - grabbing minidump binary from tooltool 07:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:21 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 0x1a86290>, '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 0x1a86b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a87040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:21 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 07:16:21 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 07:16:21 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 07:16:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:21 INFO - Return code: 0 07:16:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:21 INFO - ENV: RUST_BACKTRACE is now 1 07:16:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:21 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/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:16:21 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/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 07:16:21 INFO - Using env: {'DISPLAY': ':0', 07:16:21 INFO - 'HOME': '/home/cltbld', 07:16:21 INFO - 'LANG': 'en_US.UTF-8', 07:16:21 INFO - 'LANGUAGE': 'en_US:en', 07:16:21 INFO - 'LOGNAME': 'cltbld', 07:16:21 INFO - 'MAIL': '/var/mail/cltbld', 07:16:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:21 INFO - 'MOZ_NO_REMOTE': '1', 07:16:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:21 INFO - 'NO_EM_RESTART': '1', 07:16:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:21 INFO - 'PWD': '/builds/slave/test', 07:16:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:21 INFO - 'RUST_BACKTRACE': '1', 07:16:21 INFO - 'SHELL': '/bin/bash', 07:16:21 INFO - 'SHLVL': '1', 07:16:21 INFO - 'TERM': 'linux', 07:16:21 INFO - 'TMOUT': '86400', 07:16:21 INFO - 'USER': 'cltbld', 07:16:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591', 07:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:21 INFO - '_': '/tools/buildbot/bin/python'} 07:16:21 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/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:16:21 INFO - mozversion application_buildid: 20170329134039 07:16:21 INFO - mozversion application_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:16:21 INFO - mozversion application_display_name: Nightly 07:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:21 INFO - mozversion application_name: Firefox 07:16:21 INFO - mozversion application_remotingname: firefox 07:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:16:21 INFO - mozversion application_vendor: Mozilla 07:16:21 INFO - mozversion application_version: 55.0a1 07:16:21 INFO - mozversion platform_buildid: 20170329134039 07:16:21 INFO - mozversion platform_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:16:21 INFO - mozversion platform_version: 55.0a1 07:16:21 INFO - using testdate: 1490796981 07:16:21 INFO - actual date: 1490796981 07:16:21 INFO - starting webserver on 'localhost:55334' 07:16:21 INFO - SUITE-START | Running 2 tests 07:16:21 INFO - TEST-START | dromaeo_css 07:16:21 INFO - operating with platform_type : linux_ 07:16:21 INFO - Initialising browser for dromaeo_css test... 07:16:21 INFO - TEST-INFO | started process 20180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2IRQs/profile http://localhost:55334/getInfo.html) 07:16:25 INFO - PID 20180 | __metrics Screen width/height:1600/1200 07:16:25 INFO - PID 20180 | colorDepth:24 07:16:25 INFO - PID 20180 | Browser inner width/height: 1024/697 07:16:25 INFO - PID 20180 | __metrics 07:16:26 ERROR - PID 20180 | 1490796986882 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpD2IRQs/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpD2IRQs/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpD2IRQs/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpD2IRQs/profile/extensions/talos-powers@TalosPowersService.js:55:9 07:16:26 ERROR - PID 20180 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 07:16:27 INFO - TEST-INFO | 20180: exit 0 07:16:27 INFO - Browser initialized. 07:16:27 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:27 INFO - TEST-INFO | started process 20312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2IRQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:40 INFO - PID 20312 | RSS: Main: 156381184 07:16:40 INFO - PID 20312 | 07:19:45 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55334/tests/dromaeo/cssquery-ext.html) 07:19:47 INFO - PID 20312 | RSS: Main: 166199296 07:19:47 INFO - PID 20312 | 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | A coding exception was thrown and uncaught in a Task. 07:21:28 INFO - PID 20312 | 07:21:28 ERROR - PID 20312 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:21:28 INFO - PID 20312 | Full stack: 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | A coding exception was thrown and uncaught in a Task. 07:21:28 INFO - PID 20312 | 07:21:28 ERROR - PID 20312 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:21:28 INFO - PID 20312 | Full stack: 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | A coding exception was thrown and uncaught in a Task. 07:21:28 INFO - PID 20312 | 07:21:28 ERROR - PID 20312 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:21:28 INFO - PID 20312 | Full stack: 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | ************************* 07:21:28 INFO - PID 20312 | A coding exception was thrown and uncaught in a Task. 07:21:28 INFO - PID 20312 | 07:21:28 ERROR - PID 20312 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:21:28 INFO - PID 20312 | Full stack: 07:21:28 INFO - PID 20312 | ************************* 07:22:49 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-ext.html (next: http://localhost:55334/tests/dromaeo/cssquery-jquery.html) 07:22:50 INFO - PID 20312 | RSS: Main: 161980416 07:22:50 INFO - PID 20312 | 07:25:52 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55334/tests/dromaeo/cssquery-mootools.html) 07:25:52 INFO - PID 20312 | RSS: Main: 170086400 07:25:52 INFO - PID 20312 | 07:28:54 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55334/tests/dromaeo/cssquery-prototype.html) 07:28:55 INFO - PID 20312 | RSS: Main: 162304000 07:28:55 INFO - PID 20312 | 07:31:58 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55334/tests/dromaeo/cssquery-yui.html) 07:31:58 INFO - PID 20312 | RSS: Main: 171491328 07:31:58 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | Cycle 1(1): loaded http://localhost:55334/tests/dromaeo/cssquery-yui.html (next: http://localhost:55334/tests/dromaeo/cssquery-dojo.html) 07:35:01 INFO - PID 20312 | RSS: Main: 162660352 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | __start_tp_report 07:35:01 INFO - PID 20312 | _x_x_mozilla_page_load 07:35:01 INFO - PID 20312 | _x_x_mozilla_page_load_details 07:35:01 INFO - PID 20312 | |i|pagename|runs| 07:35:01 INFO - PID 20312 | |0;dojo.html;2736.1654695317925;2751.00963653085;2765.9585106223412;2788.1914244868976;2799.678037025742;5239.790408383669;5290.3651561812585;5301.7879284828605;5325.041492531343;5356.732163391835;5255.290535777678;5346.759395827187;5373.328333958255;5430.212619170228;5431.402545719968;4838.371011768474;4882.829100981467;4897.3878265216845;4898.387701537308;4910.729909854975;4913.729744864031;4934.950650493503;4975.2039673652225;4976.228684553882;4992.650514463989;4750.501197374295;4805.159097158018;4868.78090485929;4884.19410797218;4884.877878053042;4864.294677271811;4882;4883.365162528884;4946.950530494685;4960.900781984376;4812.1578723723205;4819.614430845559;4854.053459575384;4880.316755654211;4900.950990490085;5158.896822063538;5207.791688332462;5271.894562108736;5324.787008519655;5394.946050539523;5772.624779389326;5789.507891829199;5819.127130930352;5830.8629817185665;5835.095560188178;5807.332156801937;5817.243758311435;5819.476247137778;5821.2141360916585;5829.446202610788;5261.973690131601;5380.91928621071;5383.031054410205;5395.2986111806;5402.216678581583;5884.588078834526;5924.881502369928;5974.074018527135;5975.611585246945;6007.669578173242;5477.507024367826;5545.72271386429;5644.520215781622;5647.29408823897;5711.143328500758;5740.9953258180485;5802.709864506758;5814.854628634233;5819.912701309484;5843;5741.511971482387;5746.454086861741;5752.539796816244;5767.250257466502;5770.2498675171955;5571;5616.9157462638095;5724.799632012943;5784.4504772046585;5795.304563452412;4794.089123066607;4794.161021821237;4805.159097158054;4824.710517368969;4833.4441539223435;4094.3653733671326;4109.527404348538;4113.85601503946;4114;4139.81370838313;4787.904241915212;4831.396075490564;4837.564619184291;4839.032193561302;4920.581750551171;5652.208690783294;5673.659580425187;5709.714514274269;5711.228984087095;5713.342965558931;4801.95198048022;4821.566059054702;4841.3222148899185;4841.958978819571;4846.61227101831;5017.046761115376;5044.1424957756535;5044.991001799654;5050.84847454577;5137.8201762938115;5358.008768377785;5386.407495175606;5387.892242155213;5394.487523685244;5395.676259424447;5791.478766910998;5803.042497987784;5806.390329015392;5817.301923769175;5827.24245848037;5345.2249423832545;5346.679199248058;5364.38309594386;5377.919331209957;5404.8108316208745;5691.857703557444;5715.31416230055;5721.05602575587;5722.885542289047;5737.91393129095;5673.461021202979;5714;5820.505257053198;5828.737706803289;5841.883162336814;5466.671999680032;5513.3108361454815;5529.060059789926;5574.024545704567;5591.692456914909;5602.831915042392;5620.550355971594;5621.943780562306;5642.943570564242;5662.037453632975;5376.946230537801;5389.973050134724;5450.672959622435;5523.171524271231;5577.60956733041;5670.829875103588;5681.034224181982;5691.8292451226525;5718.142278658234;5727.055035919193;5402.75687594067;5420.457954204706;5423.484768946943;5425.159100339453;5426.810061647823 07:35:01 INFO - PID 20312 | |1;ext.html;695.8121307247044;720.8594324106798;1046.9528871200796;1079.1474734959388;1177.6820258530201;31623.68376316236;32407.67592324076;32449.188770280754;32602.347953040953;32716;30555.541666875015;30710.92511762089;30881.84559077207;30921.072367828943;31044.068677939642;5687.857803554903;5806.042003069489;6920.377166055054;7023.2625574314725;7038.401735852433;7240.710371585156;7401.81495462615;7403.333699967002;7406.185319614838;7408.407327413794;7449.9627501862415;7507;7515.812104697372;7519.458511005231;7535.924640753605;7422.220666829986;7424;7494.925050749477;7499.175090740042;7509.211532789033;7290.489665723401;7310.744123955689;7364.668589913466;7378.520396174232;7380.1512826025155;33967;34044;34175.82912085448;34191.48712769311;34212.48681269783;2682.6512553368134;2693.905713300025;2707.3367025078783;2731.9839835441867;2745.9038933637426;23832.16587419432;23842;24196.03215871363;24413.511729765483;24871.253862384157;2770.7783377329765;2799.300174956261;2801.29967508123;2817.2675104472983;2826.971730282712;145677.27161364126;145904;146029;146444.26777866148;147061;31171;31650.841745791586;36532.45201321982;41334;41769.373459398135;38154;38181;38236;38283.2772525237;38296.61703382931;10776;11340.886591134147;11357.545698172145;11361.54553817838;11426.485808138654;8922;8927.598258078402;8935.285177185939;8958.328125390492;8979.820403591892;12410.937945310216;12439.253644781342;12445.502179912883;12454.626361209179;12568.120231583884;5339.279197308391;5419.430959749169;5430.511253987082;5440.238366628675;5462.590305727007;867.5315329722006;888.9155530224748;891.2290868398788;899.6581299106429;923.6213152607398;20082.598348032956;21013.369598912057;21048;21048.89475552643;21300;950.3442624589012;960.3757557587624;986.3391527676474;988.980220395588;990.1534188268927;10769;10851.186161037953;11098.778024439465;11102.111831053497;11153;210747;211797;211909;212054;212099;40646;40690.18619627591;40842;40922.38616420756;41164;1156.5605070073486;1190.9285442873456;1201.3272567362305;1204.4820727087435;1209.8850609192114;19578.412647620593;19627.901860490605;19913.900430497753;20107.39677809668;20753.27363542329;30105.698943011164;30222.54666180053;30287.394252114394;30306.696933030387;30373;211274;211438;212909;213155;213415;28346.85826570854;28427.715722843335;28768;28890.711092888803;28946;33820.492692609136;33933.32133357369;34112.65887341095;34662.30675386428;34880.30239395147;26420.603690944266;26607.33481662974;26815.73184268132;27450.45099098047;27464.17607471779;26231.868840655676;26349.736502635496;26356.60465092987;26410.207693769218;27439.176824695292;29368.118956431343;29652.703472964993;29995.850020749756;30248.395032099674;30334.089977300715;26142.7858212681;26194.214173574823;26320.473590528465;26424.8678756605;27144.72855271422;20660.586788264452;21652.45868853291;21678;21706.457338566663;21746.782532174475 07:35:01 INFO - PID 20312 | |2;jquery.html;415.8690012646014;426.2051274373294;428.15225852811415;431.6115496053552;444.50659767657896;17215;17246.82753172468;17935.103244837755;17974.5506362341;18042.458726238234;16767.580810479743;17186.39847605331;17220.655586888253;17275.222614982325;17403.129843507806;5578.24693666356;5723.198752174699;5788.797392091277;5808.332041815203;5830.4461076197695;5761.107028410603;5861.472467477926;5862.208601838761;5873.148393482942;5889.411058894098;5641.18202860585;5777.826665200029;5785.681787501686;5787.218725472049;5848.298204215479;5734.512566431858;5793.8551536211935;5822.417758224144;5843.678597677147;5854.912176317359;6102.72537735803;6345.904811427832;6372.58578192416;6381.744730210786;6495.837604059889;23871.28386148401;24351;24635;24642.13752518671;24784.752152478424;1499.3402902722767;1523.6267114556895;1545.667681448494;1547.582152818744;1581.4148764956924;14207.147571145764;14657.633559161106;14762.70474590513;15094.773578396333;15975.92012039944;1770.7963584187855;1833.9449816505394;1867.3090956346239;1868.5982513759607;1890.0833095948453;80383.65628219755;87087.56456217679;89549.46307516952;91740.99999999933;91745.54127229321;17428.564285892702;18157.7276340855;19877.900610496854;20267.933016745814;20584.485387865123;34074.65925340765;34119.31761364759;34189.65810341915;34261.828690856884;34394.82802585971;8074.152214017444;8180.631871565674;8352.290055345242;8558.443701159405;8684.261837743736;6583.144191255202;6616.768413105518;6762.966185169141;6800.4219641330055;6814.114165158597;9048.954755226314;9183.035781243007;9307.348485605942;9344.90655093454;9522.523873806282;3746.1758413149064;3785.6403641653997;3819.427085937132;3839.9808000960375;3876.770856757376;839.1105428246078;845.1886189258258;853.7438768369465;858.1032820702382;863.3869952333913;16366.263518141712;16559.91720041392;17192;17537.736933946002;17616.20727067285;827.1972115609008;876.6274333408276;877.8332116897769;883.6818745251704;892.2727976698969;8665.913340866637;8939.463632182089;9227.815443691088;9479.620815167455;9484.573194206278;458031;464203;467096;469099;471396;68481.65759171173;79568;91505;91578.54210729037;92297.53851230702;1051.9579216831241;1105.745678493951;1127.2841745491507;1129.7288650723767;1133.9489722962487;13993.230372329619;14134.222617756122;14276.857231427553;14313;15047.77428338554;37422.625773743006;38095.61904380921;40456.797716011235;41903.1619367617;42167;50683.23975140449;50813.74593127011;50917.490825092755;50952.235716465024;51083.23375149301;7365.410767138509;7722.53664780115;7749.7287594933905;7759.844803104019;8106.892208026074;11724.531018759495;11790.882091178979;11837.881621184022;12419.19275247106;12421.565245216736;9694.903050969682;9740.951295243478;9758.658446954323;10018.298719089886;10060.69817905464;9914.504274786088;10271.640492582725;10343.94828025855;10357.9482102589;10614;10362.533685983997;10390;10501.159907207253;10758.246922715334;10831.133509319394;7680.193579674054;7736.568734784083;7796.88304675419;7859.214078592095;7918.445708800559;9583.185429238592;9602.711918642173;9661.275404344562;9697.515124243619;9908.702738917844 07:35:01 INFO - PID 20312 | |3;mootools.html;1223.865374808771;1261.8107283907414;1262.3372729317114;1266.9366531673418;1274.834271544699;9435.29235307352;9776.31565790394;9782.168515676176;9826.361286516372;10095.242856785733;9825;10020.54907529161;10030.348027378215;10031.297809153362;10035.59857605695;2172.424307558498;2208.9226877059305;2214.402111429913;2214.966775498369;2229.041512149775;2133.4026472587702;2215.656573231152;2243.663450482424;2258.288639078685;2264.0377839418184;2207.536417352358;2257.3679369776487;2266.897989590472;2267.3651377614297;2270.6026445372077;2153.2894144932293;2170.0560256288563;2202.2512345802425;2203.8347123965605;2206.393241858486;1808.9095545222685;1868.9813101869079;2044.6115238104712;2151.9462013449634;2164.21006332689;9662.420254784736;9796.412215267106;9802.215822734164;9803.460809655466;9827.606895724162;5299.092326762401;5510.669359838423;5513.255710479114;5516.117421212587;5518.641288316287;3175.682431756829;3184.9203769905707;3250.5449237106823;3258.6252580953255;3282.2286762610765;1073.57057177129;1079.4818487126224;1105.8341248812662;1130.7908037013096;1151.7293436042523;14553.708925821531;14585.416583336653;14679.192644404553;14693;14757.704845903128;4499.280115181556;4774.259989701602;4846.442659094178;4850.611951043908;4982;10496.947515262527;10513.632022879316;10538.631147909786;10573.20700947432;10602.681919542427;5379.757910894019;5393.5954803389905;5424.294841670558;5428.4028756836715;5436.21174929633;4627.259638457831;4938.111139994836;4948.802047918043;4990.426100998359;5063.063333283354;3782.1868298315994;3815.8664446744233;3891.747036442622;3932.390479475686;4048.6963477739287;1087.4182312462794;1091;1094.020851338048;1116.3580940958982;1118.6308518188978;647.4981889036035;685.1401491128602;690.1511141296234;691.1464341538197;705.8270723672733;5877.324107727581;5926.377730338339;6026.276846778414;6091.390860913962;6130.049842274455;805.4321703199231;807.6284908941952;813.8616435206029;818.0674031603976;835.2566216067704;3229.80621162731;3308.5698859148156;3364.108511244522;3394.321135772855;3423.503591979149;12525.56160534377;12944.67638309031;13129.868701313055;13133.934330328288;13146.60560183196;12801.423935922905;12857.614271571681;12915.483380664667;13188.208707477583;13298.268595227162;9476.857847132298;9487.383320084173;9516.143547080796;9645.565949532287;9675;5860.970695146497;5864.413558644102;5920.348761636131;6008.759649614141;6037.63774173551;11699;11721.882781172078;11734.413279335828;11937.104717146076;11968.521259149536;11627.709307267385;12068.939655301667;12073.335966521925;12206.572769953009;12273.754524909631;7677.731279405194;7776.339011184113;7829.765107046797;7833.255840695125;7840.529568225925;9074.45553266806;9183.403078799856;9297.30270229722;9330.486823224788;9341.11259430353;7778.144404115656;7932.286094251545;7968.243016913384;8087.9595602023965;8229.506229626002;7699.538027718355;7890.526568405684;7908.4464087513325;7988.600569971594;8093.797655058671;6844.657767111724;6921.757738479129;6955.304469553004;6956.686949087202;6975;5102.591792656504;5121.974390128025;5140.3831540215415;5203.973980130075;5396.1366181410785;5171.250168725589;5189.377274727057;5235.764390602508;5239.554637855825;5445.591580631548 07:35:01 INFO - PID 20312 | |4;prototype.html;374.8631749411464;394.439895348605;401.50013233524265;401.8171731862003;402.2457891453525;5514.255575497306;5660.773569057238;5683;5734.885302293952;5748.252727145476;5489.451054894508;5564.415736347686;5571.220029195916;5575.470330318623;5585.301837270341;4324.2648749712625;4326.6106050455455;4331.30699088146;4335.371371151181;4336.609705126538;4224.957750422503;4290.206311832321;4318.4170137031415;4332.545082766295;4362.822038049725;4247.405363249132;4264.701470897038;4286.078493123978;4287.742735435868;4307.741535507879;4266.104118135196;4268.637165840907;4276.764777937212;4296.763677997709;4301.870943871689;3705.4441833724886;3771.15149091455;3778.452124441968;3782.0733920189455;3788.6021967693546;5433.429489903543;5449;5452.536534394581;5453.318335208099;5494.890102197974;4958.9752051239875;4969.826056088055;4972.179590367585;4974.3533340665845;4987.501249874984;5691.317041954951;5876.647401155901;5896.734646940898;5901.439363260483;5915.645061296336;4081.673466122703;4100.17996400718;4102.671786257092;4106.733062350938;4122.196171746511;6000.189879426552;6183.907241391383;6202.875942481171;6204.9689751551405;6250.968745156245;4152.501699796044;4196.895077623023;4200.810963506649;4208.116295577963;4232;4277.144571085795;4278.187144442546;4286.828526858953;4288.8284468620905;4292.849750258726;4824.758762061883;4914.189158788759;4916;4918.5819205367225;4936.802527898843;5850.561207909339;5851;5891.646501209942;5904.852378690567;5910.7931222407005;1470.2575199524172;1484.9034812737139;1486.6357742353193;1488.1220080152762;1491.671832196915;952.4190243951184;995.0894931137927;998.9450580218013;999.4652860719481;1009.9091081802673;5071.746412679425;5085.160948443539;5087.465816089331;5136.717480538607;5152.454263720869;6029.969850150721;6112.7554897804475;6126.050462178369;6128.417800308964;6142.324344322121;4833.661643684979;5051.797928082909;5111.846644600668;5126.231065340229;5133.25567792668;3234.35048125453;3234.369297986917;3235.5955505561806;3255.4953982132806;3263.3473305339026;5460.945390546123;5629.155626656035;5656.349519805192;5670.291213598301;5688.203651488795;6195.256569211723;6218.378162183836;6244.438000579969;6254.371066040509;6281.937180628135;5643.927653745775;5652;5653.9151912721345;5656.745446454919;5665.971670141623;5993.0257885955425;6000;6041;6108.297545782292;6117.480014198843;5987.101934709654;5999.4900433463645;6018.3680713524445;6019.849503762266;6020.157177995172;5341.786328546815;5437.238786569963;5529.170624406211;5578.310123673911;5597.160425935979;4162.4796900387455;4187.24629566681;4188.895277618084;4202.20158169959;4214.662826973896;5984.281886173513;6029.276486821609;6120.969395152996;6127.969360153171;6134.049222370361;5817.621854579439;5852.239208902815;5852.50761055928;5891.852703682443;5900.498457631149;5827.504662103599;5832.941670583409;5875.529957603467;5883.970580147072;5884.705764711833;5541.833744987657;5721.713914304351;5745.712714364181;5751.597388182787;5805.738741756715;5897.410258974069;5908.3796201399955;5927.673977931255;5935.169076329231;5939.198208241832;5439.972800135974;5716.657000579979;5745.166950792195;5786.0453025252045;5786.5081468074 07:35:01 INFO - PID 20312 | |5;yui.html;685.4550632247363;688.0779755128129;692.3664846665301;712.1703215753644;715.4097869257863;11606.535738570457;11752.294862308267;11883.168178227528;12017.519299228032;13530.391132399041;12317.014638828894;12507.061970352215;12530.749385012317;12534.310612916286;12570.057245706563;845.6659619450313;870.5125129927245;883.266888482558;883.399288483834;886.007671408024;868.9522076285801;878.6309749905023;881.3301890563187;882.9558522073903;885.6767279942807;927.2118699105773;929.3076657889848;929.4748467116092;930.9953450232773;931.7297983584787;918.0360621347592;921.2031592672357;922.2069020642242;922.3681777982071;923.5520772425368;680.1600023970393;682.8770821252173;683.6855046678534;685.2188505104185;687.8589889072728;12400.255984640951;12701;14317.284135793272;14425.855741442661;14486.275686215648;12663;13361.398737056856;13447.731045379136;13641.385939443158;13650.726985460235;9964.651237206663;10503.36979781208;10523.84214236787;10630.574777008911;10699.679009629723;2747.4367754610257;4037.7577345359373;4045.6965727570255;4128.938065929014;4164.9583504164875;53161;60490.39509604892;60704.999999999556;60760.69619651874;61283.69358153181;9584.632902618969;9937.652182173733;10013.249006324555;10188.439635820101;10253.128484078788;19634.214631414583;19636.607267854564;19753.506162346057;19777.802221977596;19830.90084549597;6402.519811014099;6405.583637063576;6464.773732919325;6523.412892839668;6630.303818099127;3251.772375933662;3251.9837400813317;3261.8695252189646;3320.734341252694;3375.8312084395684;3455;3553.484744712054;3586.408242639935;3594.892153235407;3603.1172362770762;632.4276529740592;635.9693587391432;646.424682032991;646.5506473001313;651.0754728285846;512.8358925143918;525.1623660261877;531.1448567805829;533.815833537429;538.514176906369;8052.919470805334;8212.891259679986;8246.463979841292;8276.710315139062;8387.916120838836;540.2922171954751;560.341598621618;561.9129034999581;565.1550931357647;566.7846218436968;3669.559652841676;3789.3558095123894;3892.5134358205223;3932.410138479194;3990.9201815964097;62753.68623156855;63720.681396593645;64461;66043.33956660469;66537;41446.1710765783;51217.487825122014;52642.47357526452;56419.43580564142;56655.71672141695;48813.511864881606;48940.51059489431;49222.753886231054;50589.494105058475;51278.230826537634;7654.770356889302;7858.960705196438;7946.1656526066245;8004.199580041949;8029.1167971524255;25863;26112;26182.34544136412;26945.326366840985;27333.453330932873;32946.5058024125;32961.34077318488;33312;33720.32559348848;33791.155221118686;9598.376105553116;9637.364610137281;9668.951655241679;9869.654562090293;9996.050375214343;10147.137493312855;10494.47527623631;10513.737156571147;10590.364578125029;10594.629187978384;9169.40398874071;9483.24134069259;9671.661491848034;9694.321397502106;9736.367136136128;9631.470269134985;9795.118439340493;9908.25688073383;10069.446180460145;10242.436665983443;9550.761230969281;9603.918016305193;9605.567749451431;9638.614455421985;10103.141232995278;6900.378965892893;6921.550099243533;7101.609411482418;7158.248383919614;7180.793087731111;7763.4953728007495;7950.125486196398;7992.200779921961;8079.83840323202;8122.350211982909 07:35:01 INFO - PID 20312 | __end_tp_report 07:35:01 INFO - PID 20312 | __start_cc_report 07:35:01 INFO - PID 20312 | _x_x_mozilla_cycle_collect,387 07:35:01 INFO - PID 20312 | __end_cc_report 07:35:01 INFO - PID 20312 | __startTimestamp1490798101885__endTimestamp 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | ------- Summary: start ------- 07:35:01 INFO - PID 20312 | Number of tests: 6 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#0] dojo.html Cycles:165 Average:5276.20 Median:5395.68 stddev:612.57 (11.4%) stddev-sans-first:581.13 07:35:01 INFO - PID 20312 | Values: 2736.2 2751.0 2766.0 2788.2 2799.7 5239.8 5290.4 5301.8 5325.0 5356.7 5255.3 5346.8 5373.3 5430.2 5431.4 4838.4 4882.8 4897.4 4898.4 4910.7 4913.7 4935.0 4975.2 4976.2 4992.7 4750.5 4805.2 4868.8 4884.2 4884.9 4864.3 4882.0 4883.4 4947.0 4960.9 4812.2 4819.6 4854.1 4880.3 4901.0 5158.9 5207.8 5271.9 5324.8 5394.9 5772.6 5789.5 5819.1 5830.9 5835.1 5807.3 5817.2 5819.5 5821.2 5829.4 5262.0 5380.9 5383.0 5395.3 5402.2 5884.6 5924.9 5974.1 5975.6 6007.7 5477.5 5545.7 5644.5 5647.3 5711.1 5741.0 5802.7 5814.9 5819.9 5843.0 5741.5 5746.5 5752.5 5767.3 5770.2 5571.0 5616.9 5724.8 5784.5 5795.3 4794.1 4794.2 4805.2 4824.7 4833.4 4094.4 4109.5 4113.9 4114.0 4139.8 4787.9 4831.4 4837.6 4839.0 4920.6 5652.2 5673.7 5709.7 5711.2 5713.3 4802.0 4821.6 4841.3 4842.0 4846.6 5017.0 5044.1 5045.0 5050.8 5137.8 5358.0 5386.4 5387.9 5394.5 5395.7 5791.5 5803.0 5806.4 5817.3 5827.2 5345.2 5346.7 5364.4 5377.9 5404.8 5691.9 5715.3 5721.1 5722.9 5737.9 5673.5 5714.0 5820.5 5828.7 5841.9 5466.7 5513.3 5529.1 5574.0 5591.7 5602.8 5620.6 5621.9 5642.9 5662.0 5376.9 5390.0 5450.7 5523.2 5577.6 5670.8 5681.0 5691.8 5718.1 5727.1 5402.8 5420.5 5423.5 5425.2 5426.8 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#1] ext.html Cycles:180 Average:32437.41 Median:30050.77 stddev:50062.80 (166.6%) stddev-sans-first:50146.51 07:35:01 INFO - PID 20312 | Values: 695.8 720.9 1047.0 1079.1 1177.7 31623.7 32407.7 32449.2 32602.3 32716.0 30555.5 30710.9 30881.8 30921.1 31044.1 5687.9 5806.0 6920.4 7023.3 7038.4 7240.7 7401.8 7403.3 7406.2 7408.4 7450.0 7507.0 7515.8 7519.5 7535.9 7422.2 7424.0 7494.9 7499.2 7509.2 7290.5 7310.7 7364.7 7378.5 7380.2 33967.0 34044.0 34175.8 34191.5 34212.5 2682.7 2693.9 2707.3 2732.0 2745.9 23832.2 23842.0 24196.0 24413.5 24871.3 2770.8 2799.3 2801.3 2817.3 2827.0 145677.3 145904.0 146029.0 146444.3 147061.0 31171.0 31650.8 36532.5 41334.0 41769.4 38154.0 38181.0 38236.0 38283.3 38296.6 10776.0 11340.9 11357.5 11361.5 11426.5 8922.0 8927.6 8935.3 8958.3 8979.8 12410.9 12439.3 12445.5 12454.6 12568.1 5339.3 5419.4 5430.5 5440.2 5462.6 867.5 888.9 891.2 899.7 923.6 20082.6 21013.4 21048.0 21048.9 21300.0 950.3 960.4 986.3 989.0 990.2 10769.0 10851.2 11098.8 11102.1 11153.0 210747.0 211797.0 211909.0 212054.0 212099.0 40646.0 40690.2 40842.0 40922.4 41164.0 1156.6 1190.9 1201.3 1204.5 1209.9 19578.4 19627.9 19913.9 20107.4 20753.3 30105.7 30222.5 30287.4 30306.7 30373.0 211274.0 211438.0 212909.0 213155.0 213415.0 28346.9 28427.7 28768.0 28890.7 28946.0 33820.5 33933.3 34112.7 34662.3 34880.3 26420.6 26607.3 26815.7 27450.5 27464.2 26231.9 26349.7 26356.6 26410.2 27439.2 29368.1 29652.7 29995.9 30248.4 30334.1 26142.8 26194.2 26320.5 26424.9 27144.7 20660.6 21652.5 21678.0 21706.5 21746.8 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#2] jquery.html Cycles:180 Average:28618.71 Median:261039.62 stddev:76866.15 (29.4%) stddev-sans-first:77052.61 07:35:01 INFO - PID 20312 | Values: 415.9 426.2 428.2 431.6 444.5 17215.0 17246.8 17935.1 17974.6 18042.5 16767.6 17186.4 17220.7 17275.2 17403.1 5578.2 5723.2 5788.8 5808.3 5830.4 5761.1 5861.5 5862.2 5873.1 5889.4 5641.2 5777.8 5785.7 5787.2 5848.3 5734.5 5793.9 5822.4 5843.7 5854.9 6102.7 6345.9 6372.6 6381.7 6495.8 23871.3 24351.0 24635.0 24642.1 24784.8 1499.3 1523.6 1545.7 1547.6 1581.4 14207.1 14657.6 14762.7 15094.8 15975.9 1770.8 1833.9 1867.3 1868.6 1890.1 80383.7 87087.6 89549.5 91741.0 91745.5 17428.6 18157.7 19877.9 20267.9 20584.5 34074.7 34119.3 34189.7 34261.8 34394.8 8074.2 8180.6 8352.3 8558.4 8684.3 6583.1 6616.8 6763.0 6800.4 6814.1 9049.0 9183.0 9307.3 9344.9 9522.5 3746.2 3785.6 3819.4 3840.0 3876.8 839.1 845.2 853.7 858.1 863.4 16366.3 16559.9 17192.0 17537.7 17616.2 827.2 876.6 877.8 883.7 892.3 8665.9 8939.5 9227.8 9479.6 9484.6 458031.0 464203.0 467096.0 469099.0 471396.0 68481.7 79568.0 91505.0 91578.5 92297.5 1052.0 1105.7 1127.3 1129.7 1133.9 13993.2 14134.2 14276.9 14313.0 15047.8 37422.6 38095.6 40456.8 41903.2 42167.0 50683.2 50813.7 50917.5 50952.2 51083.2 7365.4 7722.5 7749.7 7759.8 8106.9 11724.5 11790.9 11837.9 12419.2 12421.6 9694.9 9741.0 9758.7 10018.3 10060.7 9914.5 10271.6 10343.9 10357.9 10614.0 10362.5 10390.0 10501.2 10758.2 10831.1 7680.2 7736.6 7796.9 7859.2 7918.4 9583.2 9602.7 9661.3 9697.5 9908.7 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#3] mootools.html Cycles:180 Average:6204.02 Median:4563.27 stddev:3970.80 (87.0%) stddev-sans-first:3964.31 07:35:01 INFO - PID 20312 | Values: 1223.9 1261.8 1262.3 1266.9 1274.8 9435.3 9776.3 9782.2 9826.4 10095.2 9825.0 10020.5 10030.3 10031.3 10035.6 2172.4 2208.9 2214.4 2215.0 2229.0 2133.4 2215.7 2243.7 2258.3 2264.0 2207.5 2257.4 2266.9 2267.4 2270.6 2153.3 2170.1 2202.3 2203.8 2206.4 1808.9 1869.0 2044.6 2151.9 2164.2 9662.4 9796.4 9802.2 9803.5 9827.6 5299.1 5510.7 5513.3 5516.1 5518.6 3175.7 3184.9 3250.5 3258.6 3282.2 1073.6 1079.5 1105.8 1130.8 1151.7 14553.7 14585.4 14679.2 14693.0 14757.7 4499.3 4774.3 4846.4 4850.6 4982.0 10496.9 10513.6 10538.6 10573.2 10602.7 5379.8 5393.6 5424.3 5428.4 5436.2 4627.3 4938.1 4948.8 4990.4 5063.1 3782.2 3815.9 3891.7 3932.4 4048.7 1087.4 1091.0 1094.0 1116.4 1118.6 647.5 685.1 690.2 691.1 705.8 5877.3 5926.4 6026.3 6091.4 6130.0 805.4 807.6 813.9 818.1 835.3 3229.8 3308.6 3364.1 3394.3 3423.5 12525.6 12944.7 13129.9 13133.9 13146.6 12801.4 12857.6 12915.5 13188.2 13298.3 9476.9 9487.4 9516.1 9645.6 9675.0 5861.0 5864.4 5920.3 6008.8 6037.6 11699.0 11721.9 11734.4 11937.1 11968.5 11627.7 12068.9 12073.3 12206.6 12273.8 7677.7 7776.3 7829.8 7833.3 7840.5 9074.5 9183.4 9297.3 9330.5 9341.1 7778.1 7932.3 7968.2 8088.0 8229.5 7699.5 7890.5 7908.4 7988.6 8093.8 6844.7 6921.8 6955.3 6956.7 6975.0 5102.6 5122.0 5140.4 5204.0 5396.1 5171.3 5189.4 5235.8 5239.6 5445.6 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#4] prototype.html Cycles:180 Average:4855.24 Median:5504.57 stddev:1422.79 (25.8%) stddev-sans-first:1386.47 07:35:01 INFO - PID 20312 | Values: 374.9 394.4 401.5 401.8 402.2 5514.3 5660.8 5683.0 5734.9 5748.3 5489.5 5564.4 5571.2 5575.5 5585.3 4324.3 4326.6 4331.3 4335.4 4336.6 4225.0 4290.2 4318.4 4332.5 4362.8 4247.4 4264.7 4286.1 4287.7 4307.7 4266.1 4268.6 4276.8 4296.8 4301.9 3705.4 3771.2 3778.5 3782.1 3788.6 5433.4 5449.0 5452.5 5453.3 5494.9 4959.0 4969.8 4972.2 4974.4 4987.5 5691.3 5876.6 5896.7 5901.4 5915.6 4081.7 4100.2 4102.7 4106.7 4122.2 6000.2 6183.9 6202.9 6205.0 6251.0 4152.5 4196.9 4200.8 4208.1 4232.0 4277.1 4278.2 4286.8 4288.8 4292.8 4824.8 4914.2 4916.0 4918.6 4936.8 5850.6 5851.0 5891.6 5904.9 5910.8 1470.3 1484.9 1486.6 1488.1 1491.7 952.4 995.1 998.9 999.5 1009.9 5071.7 5085.2 5087.5 5136.7 5152.5 6030.0 6112.8 6126.1 6128.4 6142.3 4833.7 5051.8 5111.8 5126.2 5133.3 3234.4 3234.4 3235.6 3255.5 3263.3 5460.9 5629.2 5656.3 5670.3 5688.2 6195.3 6218.4 6244.4 6254.4 6281.9 5643.9 5652.0 5653.9 5656.7 5666.0 5993.0 6000.0 6041.0 6108.3 6117.5 5987.1 5999.5 6018.4 6019.8 6020.2 5341.8 5437.2 5529.2 5578.3 5597.2 4162.5 4187.2 4188.9 4202.2 4214.7 5984.3 6029.3 6121.0 6128.0 6134.0 5817.6 5852.2 5852.5 5891.9 5900.5 5827.5 5832.9 5875.5 5884.0 5884.7 5541.8 5721.7 5745.7 5751.6 5805.7 5897.4 5908.4 5927.7 5935.2 5939.2 5440.0 5716.7 5745.2 5786.0 5786.5 07:35:01 INFO - PID 20312 | 07:35:01 INFO - PID 20312 | [#5] yui.html Cycles:180 Average:13483.93 Median:58573.06 stddev:16930.53 (28.9%) stddev-sans-first:16950.75 07:35:01 INFO - PID 20312 | Values: 685.5 688.1 692.4 712.2 715.4 11606.5 11752.3 11883.2 12017.5 13530.4 12317.0 12507.1 12530.7 12534.3 12570.1 845.7 870.5 883.3 883.4 886.0 869.0 878.6 881.3 883.0 885.7 927.2 929.3 929.5 931.0 931.7 918.0 921.2 922.2 922.4 923.6 680.2 682.9 683.7 685.2 687.9 12400.3 12701.0 14317.3 14425.9 14486.3 12663.0 13361.4 13447.7 13641.4 13650.7 9964.7 10503.4 10523.8 10630.6 10699.7 2747.4 4037.8 4045.7 4128.9 4165.0 53161.0 60490.4 60705.0 60760.7 61283.7 9584.6 9937.7 10013.2 10188.4 10253.1 19634.2 19636.6 19753.5 19777.8 19830.9 6402.5 6405.6 6464.8 6523.4 6630.3 3251.8 3252.0 3261.9 3320.7 3375.8 3455.0 3553.5 3586.4 3594.9 3603.1 632.4 636.0 646.4 646.6 651.1 512.8 525.2 531.1 533.8 538.5 8052.9 8212.9 8246.5 8276.7 8387.9 540.3 560.3 561.9 565.2 566.8 3669.6 3789.4 3892.5 3932.4 3990.9 62753.7 63720.7 64461.0 66043.3 66537.0 41446.2 51217.5 52642.5 56419.4 56655.7 48813.5 48940.5 49222.8 50589.5 51278.2 7654.8 7859.0 7946.2 8004.2 8029.1 25863.0 26112.0 26182.3 26945.3 27333.5 32946.5 32961.3 33312.0 33720.3 33791.2 9598.4 9637.4 9669.0 9869.7 9996.1 10147.1 10494.5 10513.7 10590.4 10594.6 9169.4 9483.2 9671.7 9694.3 9736.4 9631.5 9795.1 9908.3 10069.4 10242.4 9550.8 9603.9 9605.6 9638.6 10103.1 6900.4 6921.6 7101.6 7158.2 7180.8 7763.5 7950.1 7992.2 8079.8 8122.4 07:35:01 INFO - PID 20312 | -------- Summary: end -------- 07:35:01 INFO - PID 20312 | 07:35:02 INFO - TEST-INFO | 20312: exit 0 07:35:02 INFO - TEST-OK | dromaeo_css | took 1121486ms 07:35:02 INFO - TEST-START | kraken 07:35:02 INFO - operating with platform_type : linux_ 07:35:02 INFO - Initialising browser for kraken test... 07:35:02 INFO - TEST-INFO | started process 20698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDro6_/profile http://localhost:55334/getInfo.html) 07:35:07 INFO - PID 20698 | __metrics Screen width/height:1600/1200 07:35:07 INFO - PID 20698 | colorDepth:24 07:35:07 INFO - PID 20698 | Browser inner width/height: 1024/697 07:35:07 INFO - PID 20698 | __metrics 07:35:08 ERROR - PID 20698 | 1490798108601 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpWDro6_/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpWDro6_/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpWDro6_/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpWDro6_/profile/extensions/talos-powers@TalosPowersService.js:55:9 07:35:08 ERROR - PID 20698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 07:35:09 INFO - TEST-INFO | 20698: exit 0 07:35:09 INFO - Browser initialized. 07:35:09 INFO - Running cycle 1/1 for kraken test... 07:35:09 INFO - TEST-INFO | started process 20828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDro6_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:21 INFO - PID 20828 | RSS: Main: 156237824 07:35:21 INFO - PID 20828 | 07:35:24 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55334/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:25 INFO - PID 20828 | RSS: Main: 163303424 07:35:25 INFO - PID 20828 | 07:35:28 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55334/tests/kraken/driver.html?testName=audio-dft) 07:35:28 INFO - PID 20828 | RSS: Main: 161906688 07:35:28 INFO - PID 20828 | 07:35:31 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55334/tests/kraken/driver.html?testName=audio-fft) 07:35:32 INFO - PID 20828 | RSS: Main: 158310400 07:35:32 INFO - PID 20828 | 07:35:34 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55334/tests/kraken/driver.html?testName=audio-oscillator) 07:35:35 INFO - PID 20828 | RSS: Main: 158871552 07:35:35 INFO - PID 20828 | 07:35:37 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:38 INFO - PID 20828 | RSS: Main: 159182848 07:35:38 INFO - PID 20828 | 07:35:41 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55334/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:41 INFO - PID 20828 | RSS: Main: 164331520 07:35:41 INFO - PID 20828 | 07:35:45 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55334/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:46 INFO - PID 20828 | RSS: Main: 162037760 07:35:46 INFO - PID 20828 | 07:35:49 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55334/tests/kraken/driver.html?testName=json-parse-financial) 07:35:49 INFO - PID 20828 | RSS: Main: 163004416 07:35:49 INFO - PID 20828 | 07:35:51 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:52 INFO - PID 20828 | RSS: Main: 163639296 07:35:52 INFO - PID 20828 | 07:35:53 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:54 INFO - PID 20828 | RSS: Main: 163545088 07:35:54 INFO - PID 20828 | 07:35:56 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:57 INFO - PID 20828 | RSS: Main: 164061184 07:35:57 INFO - PID 20828 | 07:36:00 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:01 INFO - PID 20828 | RSS: Main: 164810752 07:36:01 INFO - PID 20828 | 07:36:04 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:05 INFO - PID 20828 | RSS: Main: 164425728 07:36:05 INFO - PID 20828 | 07:36:06 INFO - PID 20828 | Cycle 1(1): loaded http://localhost:55334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55334/tests/kraken/driver.html?testName=ai-astar) 07:36:07 INFO - PID 20828 | RSS: Main: 166092800 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | __start_tp_report 07:36:07 INFO - PID 20828 | _x_x_mozilla_page_load 07:36:07 INFO - PID 20828 | _x_x_mozilla_page_load_details 07:36:07 INFO - PID 20828 | |i|pagename|runs| 07:36:07 INFO - PID 20828 | |0;ai-astar;107;113;112;113;112;113;113;113;110;112 07:36:07 INFO - PID 20828 | |1;audio-beat-detection;151;129;125;182;130;125;131;127;155;128 07:36:07 INFO - PID 20828 | |2;audio-dft;169;167;166;168;171;169;169;165;165;168 07:36:07 INFO - PID 20828 | |3;audio-fft;76;75;79;110;76;77;75;76;94;76 07:36:07 INFO - PID 20828 | |4;audio-oscillator;86;84;115;85;84;86;105;92;86;114 07:36:07 INFO - PID 20828 | |5;imaging-gaussian-blur;116;114;119;115;114;120;114;114;115;115 07:36:07 INFO - PID 20828 | |6;imaging-darkroom;153;151;157;152;153;152;152;154;154;152 07:36:07 INFO - PID 20828 | |7;imaging-desaturate;94;96;96;94;95;95;95;95;94;95 07:36:07 INFO - PID 20828 | |8;json-parse-financial;70;72;69;72;73;72;71;73;72;71 07:36:07 INFO - PID 20828 | |9;json-stringify-tinderbox;55;56;56;55;55;56;56;59;56;55 07:36:07 INFO - PID 20828 | |10;stanford-crypto-aes;82;83;84;84;84;85;84;83;83;82 07:36:07 INFO - PID 20828 | |11;stanford-crypto-ccm;145;139;134;146;142;136;137;134;233;141 07:36:07 INFO - PID 20828 | |12;stanford-crypto-pbkdf2;189;201;208;199;189;196;209;188;188;194 07:36:07 INFO - PID 20828 | |13;stanford-crypto-sha256-iterative;75;71;73;71;71;71;73;72;72;74 07:36:07 INFO - PID 20828 | __end_tp_report 07:36:07 INFO - PID 20828 | __start_cc_report 07:36:07 INFO - PID 20828 | _x_x_mozilla_cycle_collect,878 07:36:07 INFO - PID 20828 | __end_cc_report 07:36:07 INFO - PID 20828 | __startTimestamp1490798167118__endTimestamp 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | ------- Summary: start ------- 07:36:07 INFO - PID 20828 | Number of tests: 14 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:1.93 (1.7%) stddev-sans-first:1.00 07:36:07 INFO - PID 20828 | Values: 107.0 113.0 112.0 113.0 112.0 113.0 113.0 113.0 110.0 112.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:130.50 stddev:18.70 (14.3%) stddev-sans-first:19.26 07:36:07 INFO - PID 20828 | Values: 151.0 129.0 125.0 182.0 130.0 125.0 131.0 127.0 155.0 128.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#2] audio-dft Cycles:10 Average:167.70 Median:168.50 stddev:1.95 (1.2%) stddev-sans-first:2.01 07:36:07 INFO - PID 20828 | Values: 169.0 167.0 166.0 168.0 171.0 169.0 169.0 165.0 165.0 168.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.55 (15.2%) stddev-sans-first:12.08 07:36:07 INFO - PID 20828 | Values: 76.0 75.0 79.0 110.0 76.0 77.0 75.0 76.0 94.0 76.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:85.50 stddev:12.64 (14.8%) stddev-sans-first:13.10 07:36:07 INFO - PID 20828 | Values: 86.0 84.0 115.0 85.0 84.0 86.0 105.0 92.0 86.0 114.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:2.17 (1.9%) stddev-sans-first:2.30 07:36:07 INFO - PID 20828 | Values: 116.0 114.0 119.0 115.0 114.0 120.0 114.0 114.0 115.0 115.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#6] imaging-darkroom Cycles:10 Average:153.00 Median:153.00 stddev:1.70 (1.1%) stddev-sans-first:1.80 07:36:07 INFO - PID 20828 | Values: 153.0 151.0 157.0 152.0 153.0 152.0 152.0 154.0 154.0 152.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 07:36:07 INFO - PID 20828 | Values: 94.0 96.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:72.00 stddev:1.27 (1.8%) stddev-sans-first:1.22 07:36:07 INFO - PID 20828 | Values: 70.0 72.0 69.0 72.0 73.0 72.0 71.0 73.0 72.0 71.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 07:36:07 INFO - PID 20828 | Values: 55.0 56.0 56.0 55.0 55.0 56.0 56.0 59.0 56.0 55.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 07:36:07 INFO - PID 20828 | Values: 82.0 83.0 84.0 84.0 84.0 85.0 84.0 83.0 83.0 82.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:141.50 stddev:29.92 (21.1%) stddev-sans-first:31.70 07:36:07 INFO - PID 20828 | Values: 145.0 139.0 134.0 146.0 142.0 136.0 137.0 134.0 233.0 141.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.10 Median:197.50 stddev:8.01 (4.1%) stddev-sans-first:8.07 07:36:07 INFO - PID 20828 | Values: 189.0 201.0 208.0 199.0 189.0 196.0 209.0 188.0 188.0 194.0 07:36:07 INFO - PID 20828 | 07:36:07 INFO - PID 20828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.42 (2.0%) stddev-sans-first:1.12 07:36:07 INFO - PID 20828 | Values: 75.0 71.0 73.0 71.0 71.0 71.0 73.0 72.0 72.0 74.0 07:36:07 INFO - PID 20828 | -------- Summary: end -------- 07:36:07 INFO - PID 20828 | 07:36:08 INFO - TEST-INFO | 20828: exit 0 07:36:08 INFO - TEST-OK | kraken | took 65521ms 07:36:08 INFO - SUITE-END | took 1187s 07:36:08 INFO - Completed test suite (00:19:47) 07:36:08 INFO - javascript benchmark 07:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6675.075685548728, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2736.1654695317925, 2751.00963653085, 2765.9585106223412, 2788.1914244868976, 2799.678037025742, 5239.790408383669, 5290.3651561812585, 5301.7879284828605, 5325.041492531343, 5356.732163391835, 5255.290535777678, 5346.759395827187, 5373.328333958255, 5430.212619170228, 5431.402545719968, 4838.371011768474, 4882.829100981467, 4897.3878265216845, 4898.387701537308, 4910.729909854975, 4913.729744864031, 4934.950650493503, 4975.2039673652225, 4976.228684553882, 4992.650514463989, 4750.501197374295, 4805.159097158018, 4868.78090485929, 4884.19410797218, 4884.877878053042, 4864.294677271811, 4882.0, 4883.365162528884, 4946.950530494685, 4960.900781984376, 4812.1578723723205, 4819.614430845559, 4854.053459575384, 4880.316755654211, 4900.950990490085, 5158.896822063538, 5207.791688332462, 5271.894562108736, 5324.787008519655, 5394.946050539523, 5772.624779389326, 5789.507891829199, 5819.127130930352, 5830.8629817185665, 5835.095560188178, 5807.332156801937, 5817.243758311435, 5819.476247137778, 5821.2141360916585, 5829.446202610788, 5261.973690131601, 5380.91928621071, 5383.031054410205, 5395.2986111806, 5402.216678581583, 5884.588078834526, 5924.881502369928, 5974.074018527135, 5975.611585246945, 6007.669578173242, 5477.507024367826, 5545.72271386429, 5644.520215781622, 5647.29408823897, 5711.143328500758, 5740.9953258180485, 5802.709864506758, 5814.854628634233, 5819.912701309484, 5843.0, 5741.511971482387, 5746.454086861741, 5752.539796816244, 5767.250257466502, 5770.2498675171955, 5571.0, 5616.9157462638095, 5724.799632012943, 5784.4504772046585, 5795.304563452412, 4794.089123066607, 4794.161021821237, 4805.159097158054, 4824.710517368969, 4833.4441539223435, 4094.3653733671326, 4109.527404348538, 4113.85601503946, 4114.0, 4139.81370838313, 4787.904241915212, 4831.396075490564, 4837.564619184291, 4839.032193561302, 4920.581750551171, 5652.208690783294, 5673.659580425187, 5709.714514274269, 5711.228984087095, 5713.342965558931, 4801.95198048022, 4821.566059054702, 4841.3222148899185, 4841.958978819571, 4846.61227101831, 5017.046761115376, 5044.1424957756535, 5044.991001799654, 5050.84847454577, 5137.8201762938115, 5358.008768377785, 5386.407495175606, 5387.892242155213, 5394.487523685244, 5395.676259424447, 5791.478766910998, 5803.042497987784, 5806.390329015392, 5817.301923769175, 5827.24245848037, 5345.2249423832545, 5346.679199248058, 5364.38309594386, 5377.919331209957, 5404.8108316208745, 5691.857703557444, 5715.31416230055, 5721.05602575587, 5722.885542289047, 5737.91393129095, 5673.461021202979, 5714.0, 5820.505257053198, 5828.737706803289, 5841.883162336814, 5466.671999680032, 5513.3108361454815, 5529.060059789926, 5574.024545704567, 5591.692456914909, 5602.831915042392, 5620.550355971594, 5621.943780562306, 5642.943570564242, 5662.037453632975, 5376.946230537801, 5389.973050134724, 5450.672959622435, 5523.171524271231, 5577.60956733041, 5670.829875103588, 5681.034224181982, 5691.8292451226525, 5718.142278658234, 5727.055035919193, 5402.75687594067, 5420.457954204706, 5423.484768946943, 5425.159100339453, 5426.810061647823], "value": 5231.788077072727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.8121307247044, 720.8594324106798, 1046.9528871200796, 1079.1474734959388, 1177.6820258530201, 31623.68376316236, 32407.67592324076, 32449.188770280754, 32602.347953040953, 32716.0, 30555.541666875015, 30710.92511762089, 30881.84559077207, 30921.072367828943, 31044.068677939642, 5687.857803554903, 5806.042003069489, 6920.377166055054, 7023.2625574314725, 7038.401735852433, 7240.710371585156, 7401.81495462615, 7403.333699967002, 7406.185319614838, 7408.407327413794, 7449.9627501862415, 7507.0, 7515.812104697372, 7519.458511005231, 7535.924640753605, 7422.220666829986, 7424.0, 7494.925050749477, 7499.175090740042, 7509.211532789033, 7290.489665723401, 7310.744123955689, 7364.668589913466, 7378.520396174232, 7380.1512826025155, 33967.0, 34044.0, 34175.82912085448, 34191.48712769311, 34212.48681269783, 2682.6512553368134, 2693.905713300025, 2707.3367025078783, 2731.9839835441867, 2745.9038933637426, 23832.16587419432, 23842.0, 24196.03215871363, 24413.511729765483, 24871.253862384157, 2770.7783377329765, 2799.300174956261, 2801.29967508123, 2817.2675104472983, 2826.971730282712, 145677.27161364126, 145904.0, 146029.0, 146444.26777866148, 147061.0, 31171.0, 31650.841745791586, 36532.45201321982, 41334.0, 41769.373459398135, 38154.0, 38181.0, 38236.0, 38283.2772525237, 38296.61703382931, 10776.0, 11340.886591134147, 11357.545698172145, 11361.54553817838, 11426.485808138654, 8922.0, 8927.598258078402, 8935.285177185939, 8958.328125390492, 8979.820403591892, 12410.937945310216, 12439.253644781342, 12445.502179912883, 12454.626361209179, 12568.120231583884, 5339.279197308391, 5419.430959749169, 5430.511253987082, 5440.238366628675, 5462.590305727007, 867.5315329722006, 888.9155530224748, 891.2290868398788, 899.6581299106429, 923.6213152607398, 20082.598348032956, 21013.369598912057, 21048.0, 21048.89475552643, 21300.0, 950.3442624589012, 960.3757557587624, 986.3391527676474, 988.980220395588, 990.1534188268927, 10769.0, 10851.186161037953, 11098.778024439465, 11102.111831053497, 11153.0, 210747.0, 211797.0, 211909.0, 212054.0, 212099.0, 40646.0, 40690.18619627591, 40842.0, 40922.38616420756, 41164.0, 1156.5605070073486, 1190.9285442873456, 1201.3272567362305, 1204.4820727087435, 1209.8850609192114, 19578.412647620593, 19627.901860490605, 19913.900430497753, 20107.39677809668, 20753.27363542329, 30105.698943011164, 30222.54666180053, 30287.394252114394, 30306.696933030387, 30373.0, 211274.0, 211438.0, 212909.0, 213155.0, 213415.0, 28346.85826570854, 28427.715722843335, 28768.0, 28890.711092888803, 28946.0, 33820.492692609136, 33933.32133357369, 34112.65887341095, 34662.30675386428, 34880.30239395147, 26420.603690944266, 26607.33481662974, 26815.73184268132, 27450.45099098047, 27464.17607471779, 26231.868840655676, 26349.736502635496, 26356.60465092987, 26410.207693769218, 27439.176824695292, 29368.118956431343, 29652.703472964993, 29995.850020749756, 30248.395032099674, 30334.089977300715, 26142.7858212681, 26194.214173574823, 26320.473590528465, 26424.8678756605, 27144.72855271422, 20660.586788264452, 21652.45868853291, 21678.0, 21706.457338566663, 21746.782532174475], "value": 14411.10015813261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.8690012646014, 426.2051274373294, 428.15225852811415, 431.6115496053552, 444.50659767657896, 17215.0, 17246.82753172468, 17935.103244837755, 17974.5506362341, 18042.458726238234, 16767.580810479743, 17186.39847605331, 17220.655586888253, 17275.222614982325, 17403.129843507806, 5578.24693666356, 5723.198752174699, 5788.797392091277, 5808.332041815203, 5830.4461076197695, 5761.107028410603, 5861.472467477926, 5862.208601838761, 5873.148393482942, 5889.411058894098, 5641.18202860585, 5777.826665200029, 5785.681787501686, 5787.218725472049, 5848.298204215479, 5734.512566431858, 5793.8551536211935, 5822.417758224144, 5843.678597677147, 5854.912176317359, 6102.72537735803, 6345.904811427832, 6372.58578192416, 6381.744730210786, 6495.837604059889, 23871.28386148401, 24351.0, 24635.0, 24642.13752518671, 24784.752152478424, 1499.3402902722767, 1523.6267114556895, 1545.667681448494, 1547.582152818744, 1581.4148764956924, 14207.147571145764, 14657.633559161106, 14762.70474590513, 15094.773578396333, 15975.92012039944, 1770.7963584187855, 1833.9449816505394, 1867.3090956346239, 1868.5982513759607, 1890.0833095948453, 80383.65628219755, 87087.56456217679, 89549.46307516952, 91740.99999999933, 91745.54127229321, 17428.564285892702, 18157.7276340855, 19877.900610496854, 20267.933016745814, 20584.485387865123, 34074.65925340765, 34119.31761364759, 34189.65810341915, 34261.828690856884, 34394.82802585971, 8074.152214017444, 8180.631871565674, 8352.290055345242, 8558.443701159405, 8684.261837743736, 6583.144191255202, 6616.768413105518, 6762.966185169141, 6800.4219641330055, 6814.114165158597, 9048.954755226314, 9183.035781243007, 9307.348485605942, 9344.90655093454, 9522.523873806282, 3746.1758413149064, 3785.6403641653997, 3819.427085937132, 3839.9808000960375, 3876.770856757376, 839.1105428246078, 845.1886189258258, 853.7438768369465, 858.1032820702382, 863.3869952333913, 16366.263518141712, 16559.91720041392, 17192.0, 17537.736933946002, 17616.20727067285, 827.1972115609008, 876.6274333408276, 877.8332116897769, 883.6818745251704, 892.2727976698969, 8665.913340866637, 8939.463632182089, 9227.815443691088, 9479.620815167455, 9484.573194206278, 458031.0, 464203.0, 467096.0, 469099.0, 471396.0, 68481.65759171173, 79568.0, 91505.0, 91578.54210729037, 92297.53851230702, 1051.9579216831241, 1105.745678493951, 1127.2841745491507, 1129.7288650723767, 1133.9489722962487, 13993.230372329619, 14134.222617756122, 14276.857231427553, 14313.0, 15047.77428338554, 37422.625773743006, 38095.61904380921, 40456.797716011235, 41903.1619367617, 42167.0, 50683.23975140449, 50813.74593127011, 50917.490825092755, 50952.235716465024, 51083.23375149301, 7365.410767138509, 7722.53664780115, 7749.7287594933905, 7759.844803104019, 8106.892208026074, 11724.531018759495, 11790.882091178979, 11837.881621184022, 12419.19275247106, 12421.565245216736, 9694.903050969682, 9740.951295243478, 9758.658446954323, 10018.298719089886, 10060.69817905464, 9914.504274786088, 10271.640492582725, 10343.94828025855, 10357.9482102589, 10614.0, 10362.533685983997, 10390.0, 10501.159907207253, 10758.246922715334, 10831.133509319394, 7680.193579674054, 7736.568734784083, 7796.88304675419, 7859.214078592095, 7918.445708800559, 9583.185429238592, 9602.711918642173, 9661.275404344562, 9697.515124243619, 9908.702738917844], "value": 9440.6229544226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.865374808771, 1261.8107283907414, 1262.3372729317114, 1266.9366531673418, 1274.834271544699, 9435.29235307352, 9776.31565790394, 9782.168515676176, 9826.361286516372, 10095.242856785733, 9825.0, 10020.54907529161, 10030.348027378215, 10031.297809153362, 10035.59857605695, 2172.424307558498, 2208.9226877059305, 2214.402111429913, 2214.966775498369, 2229.041512149775, 2133.4026472587702, 2215.656573231152, 2243.663450482424, 2258.288639078685, 2264.0377839418184, 2207.536417352358, 2257.3679369776487, 2266.897989590472, 2267.3651377614297, 2270.6026445372077, 2153.2894144932293, 2170.0560256288563, 2202.2512345802425, 2203.8347123965605, 2206.393241858486, 1808.9095545222685, 1868.9813101869079, 2044.6115238104712, 2151.9462013449634, 2164.21006332689, 9662.420254784736, 9796.412215267106, 9802.215822734164, 9803.460809655466, 9827.606895724162, 5299.092326762401, 5510.669359838423, 5513.255710479114, 5516.117421212587, 5518.641288316287, 3175.682431756829, 3184.9203769905707, 3250.5449237106823, 3258.6252580953255, 3282.2286762610765, 1073.57057177129, 1079.4818487126224, 1105.8341248812662, 1130.7908037013096, 1151.7293436042523, 14553.708925821531, 14585.416583336653, 14679.192644404553, 14693.0, 14757.704845903128, 4499.280115181556, 4774.259989701602, 4846.442659094178, 4850.611951043908, 4982.0, 10496.947515262527, 10513.632022879316, 10538.631147909786, 10573.20700947432, 10602.681919542427, 5379.757910894019, 5393.5954803389905, 5424.294841670558, 5428.4028756836715, 5436.21174929633, 4627.259638457831, 4938.111139994836, 4948.802047918043, 4990.426100998359, 5063.063333283354, 3782.1868298315994, 3815.8664446744233, 3891.747036442622, 3932.390479475686, 4048.6963477739287, 1087.4182312462794, 1091.0, 1094.020851338048, 1116.3580940958982, 1118.6308518188978, 647.4981889036035, 685.1401491128602, 690.1511141296234, 691.1464341538197, 705.8270723672733, 5877.324107727581, 5926.377730338339, 6026.276846778414, 6091.390860913962, 6130.049842274455, 805.4321703199231, 807.6284908941952, 813.8616435206029, 818.0674031603976, 835.2566216067704, 3229.80621162731, 3308.5698859148156, 3364.108511244522, 3394.321135772855, 3423.503591979149, 12525.56160534377, 12944.67638309031, 13129.868701313055, 13133.934330328288, 13146.60560183196, 12801.423935922905, 12857.614271571681, 12915.483380664667, 13188.208707477583, 13298.268595227162, 9476.857847132298, 9487.383320084173, 9516.143547080796, 9645.565949532287, 9675.0, 5860.970695146497, 5864.413558644102, 5920.348761636131, 6008.759649614141, 6037.63774173551, 11699.0, 11721.882781172078, 11734.413279335828, 11937.104717146076, 11968.521259149536, 11627.709307267385, 12068.939655301667, 12073.335966521925, 12206.572769953009, 12273.754524909631, 7677.731279405194, 7776.339011184113, 7829.765107046797, 7833.255840695125, 7840.529568225925, 9074.45553266806, 9183.403078799856, 9297.30270229722, 9330.486823224788, 9341.11259430353, 7778.144404115656, 7932.286094251545, 7968.243016913384, 8087.9595602023965, 8229.506229626002, 7699.538027718355, 7890.526568405684, 7908.4464087513325, 7988.600569971594, 8093.797655058671, 6844.657767111724, 6921.757738479129, 6955.304469553004, 6956.686949087202, 6975.0, 5102.591792656504, 5121.974390128025, 5140.3831540215415, 5203.973980130075, 5396.1366181410785, 5171.250168725589, 5189.377274727057, 5235.764390602508, 5239.554637855825, 5445.591580631548], "value": 4673.597519689548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8631749411464, 394.439895348605, 401.50013233524265, 401.8171731862003, 402.2457891453525, 5514.255575497306, 5660.773569057238, 5683.0, 5734.885302293952, 5748.252727145476, 5489.451054894508, 5564.415736347686, 5571.220029195916, 5575.470330318623, 5585.301837270341, 4324.2648749712625, 4326.6106050455455, 4331.30699088146, 4335.371371151181, 4336.609705126538, 4224.957750422503, 4290.206311832321, 4318.4170137031415, 4332.545082766295, 4362.822038049725, 4247.405363249132, 4264.701470897038, 4286.078493123978, 4287.742735435868, 4307.741535507879, 4266.104118135196, 4268.637165840907, 4276.764777937212, 4296.763677997709, 4301.870943871689, 3705.4441833724886, 3771.15149091455, 3778.452124441968, 3782.0733920189455, 3788.6021967693546, 5433.429489903543, 5449.0, 5452.536534394581, 5453.318335208099, 5494.890102197974, 4958.9752051239875, 4969.826056088055, 4972.179590367585, 4974.3533340665845, 4987.501249874984, 5691.317041954951, 5876.647401155901, 5896.734646940898, 5901.439363260483, 5915.645061296336, 4081.673466122703, 4100.17996400718, 4102.671786257092, 4106.733062350938, 4122.196171746511, 6000.189879426552, 6183.907241391383, 6202.875942481171, 6204.9689751551405, 6250.968745156245, 4152.501699796044, 4196.895077623023, 4200.810963506649, 4208.116295577963, 4232.0, 4277.144571085795, 4278.187144442546, 4286.828526858953, 4288.8284468620905, 4292.849750258726, 4824.758762061883, 4914.189158788759, 4916.0, 4918.5819205367225, 4936.802527898843, 5850.561207909339, 5851.0, 5891.646501209942, 5904.852378690567, 5910.7931222407005, 1470.2575199524172, 1484.9034812737139, 1486.6357742353193, 1488.1220080152762, 1491.671832196915, 952.4190243951184, 995.0894931137927, 998.9450580218013, 999.4652860719481, 1009.9091081802673, 5071.746412679425, 5085.160948443539, 5087.465816089331, 5136.717480538607, 5152.454263720869, 6029.969850150721, 6112.7554897804475, 6126.050462178369, 6128.417800308964, 6142.324344322121, 4833.661643684979, 5051.797928082909, 5111.846644600668, 5126.231065340229, 5133.25567792668, 3234.35048125453, 3234.369297986917, 3235.5955505561806, 3255.4953982132806, 3263.3473305339026, 5460.945390546123, 5629.155626656035, 5656.349519805192, 5670.291213598301, 5688.203651488795, 6195.256569211723, 6218.378162183836, 6244.438000579969, 6254.371066040509, 6281.937180628135, 5643.927653745775, 5652.0, 5653.9151912721345, 5656.745446454919, 5665.971670141623, 5993.0257885955425, 6000.0, 6041.0, 6108.297545782292, 6117.480014198843, 5987.101934709654, 5999.4900433463645, 6018.3680713524445, 6019.849503762266, 6020.157177995172, 5341.786328546815, 5437.238786569963, 5529.170624406211, 5578.310123673911, 5597.160425935979, 4162.4796900387455, 4187.24629566681, 4188.895277618084, 4202.20158169959, 4214.662826973896, 5984.281886173513, 6029.276486821609, 6120.969395152996, 6127.969360153171, 6134.049222370361, 5817.621854579439, 5852.239208902815, 5852.50761055928, 5891.852703682443, 5900.498457631149, 5827.504662103599, 5832.941670583409, 5875.529957603467, 5883.970580147072, 5884.705764711833, 5541.833744987657, 5721.713914304351, 5745.712714364181, 5751.597388182787, 5805.738741756715, 5897.410258974069, 5908.3796201399955, 5927.673977931255, 5935.169076329231, 5939.198208241832, 5439.972800135974, 5716.657000579979, 5745.166950792195, 5786.0453025252045, 5786.5081468074], "value": 4417.422141691847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4550632247363, 688.0779755128129, 692.3664846665301, 712.1703215753644, 715.4097869257863, 11606.535738570457, 11752.294862308267, 11883.168178227528, 12017.519299228032, 13530.391132399041, 12317.014638828894, 12507.061970352215, 12530.749385012317, 12534.310612916286, 12570.057245706563, 845.6659619450313, 870.5125129927245, 883.266888482558, 883.399288483834, 886.007671408024, 868.9522076285801, 878.6309749905023, 881.3301890563187, 882.9558522073903, 885.6767279942807, 927.2118699105773, 929.3076657889848, 929.4748467116092, 930.9953450232773, 931.7297983584787, 918.0360621347592, 921.2031592672357, 922.2069020642242, 922.3681777982071, 923.5520772425368, 680.1600023970393, 682.8770821252173, 683.6855046678534, 685.2188505104185, 687.8589889072728, 12400.255984640951, 12701.0, 14317.284135793272, 14425.855741442661, 14486.275686215648, 12663.0, 13361.398737056856, 13447.731045379136, 13641.385939443158, 13650.726985460235, 9964.651237206663, 10503.36979781208, 10523.84214236787, 10630.574777008911, 10699.679009629723, 2747.4367754610257, 4037.7577345359373, 4045.6965727570255, 4128.938065929014, 4164.9583504164875, 53161.0, 60490.39509604892, 60704.999999999556, 60760.69619651874, 61283.69358153181, 9584.632902618969, 9937.652182173733, 10013.249006324555, 10188.439635820101, 10253.128484078788, 19634.214631414583, 19636.607267854564, 19753.506162346057, 19777.802221977596, 19830.90084549597, 6402.519811014099, 6405.583637063576, 6464.773732919325, 6523.412892839668, 6630.303818099127, 3251.772375933662, 3251.9837400813317, 3261.8695252189646, 3320.734341252694, 3375.8312084395684, 3455.0, 3553.484744712054, 3586.408242639935, 3594.892153235407, 3603.1172362770762, 632.4276529740592, 635.9693587391432, 646.424682032991, 646.5506473001313, 651.0754728285846, 512.8358925143918, 525.1623660261877, 531.1448567805829, 533.815833537429, 538.514176906369, 8052.919470805334, 8212.891259679986, 8246.463979841292, 8276.710315139062, 8387.916120838836, 540.2922171954751, 560.341598621618, 561.9129034999581, 565.1550931357647, 566.7846218436968, 3669.559652841676, 3789.3558095123894, 3892.5134358205223, 3932.410138479194, 3990.9201815964097, 62753.68623156855, 63720.681396593645, 64461.0, 66043.33956660469, 66537.0, 41446.1710765783, 51217.487825122014, 52642.47357526452, 56419.43580564142, 56655.71672141695, 48813.511864881606, 48940.51059489431, 49222.753886231054, 50589.494105058475, 51278.230826537634, 7654.770356889302, 7858.960705196438, 7946.1656526066245, 8004.199580041949, 8029.1167971524255, 25863.0, 26112.0, 26182.34544136412, 26945.326366840985, 27333.453330932873, 32946.5058024125, 32961.34077318488, 33312.0, 33720.32559348848, 33791.155221118686, 9598.376105553116, 9637.364610137281, 9668.951655241679, 9869.654562090293, 9996.050375214343, 10147.137493312855, 10494.47527623631, 10513.737156571147, 10590.364578125029, 10594.629187978384, 9169.40398874071, 9483.24134069259, 9671.661491848034, 9694.321397502106, 9736.367136136128, 9631.470269134985, 9795.118439340493, 9908.25688073383, 10069.446180460145, 10242.436665983443, 9550.761230969281, 9603.918016305193, 9605.567749451431, 9638.614455421985, 10103.141232995278, 6900.378965892893, 6921.550099243533, 7101.609411482418, 7158.248383919614, 7180.793087731111, 7763.4953728007495, 7950.125486196398, 7992.200779921961, 8079.83840323202, 8122.350211982909], "value": 6019.173491965052, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0, 110.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 125.0, 182.0, 130.0, 125.0, 131.0, 127.0, 155.0, 128.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 166.0, 168.0, 171.0, 169.0, 169.0, 165.0, 165.0, 168.0], "value": 167.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 110.0, 76.0, 77.0, 75.0, 76.0, 94.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 115.0, 85.0, 84.0, 86.0, 105.0, 92.0, 86.0, 114.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 119.0, 115.0, 114.0, 120.0, 114.0, 114.0, 115.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 157.0, 152.0, 153.0, 152.0, 152.0, 154.0, 154.0, 152.0], "value": 153.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 72.0, 73.0, 72.0, 71.0, 73.0, 72.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 59.0, 56.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 84.0, 84.0, 85.0, 84.0, 83.0, 83.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 134.0, 146.0, 142.0, 136.0, 137.0, 134.0, 233.0, 141.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 201.0, 208.0, 199.0, 189.0, 196.0, 209.0, 188.0, 188.0, 194.0], "value": 196.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 71.0, 73.0, 71.0, 71.0, 71.0, 73.0, 72.0, 72.0, 74.0], "value": 72.3, "unit": "score"}]}]} 07:36:08 INFO - Return code: 0 07:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:08 ERROR - # TBPL SUCCESS # 07:36:08 INFO - Running post-action listener: _resource_record_post_action 07:36:08 INFO - [mozharness: 2017-03-29 14:36:08.919146Z] Finished run-tests step (success) 07:36:08 INFO - Running post-run listener: _resource_record_post_run 07:36:08 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 364478464; Read time: 44; Write time: 261812 07:36:08 INFO - TinderboxPrint: CPU usage
13.4% 07:36:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 44 07:36:08 INFO - TinderboxPrint: I/O write bytes / time
364,478,464 / 261,812 07:36:08 INFO - TinderboxPrint: CPU idle
8,317.6 (86.6%) 07:36:08 INFO - TinderboxPrint: CPU user
1,223.9 (12.7%) 07:36:08 INFO - TinderboxPrint: Swap in / out
0 / 0 07:36:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105947136; Read time: 0; Write time: 74148 07:36:09 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 258531328; Read time: 44; Write time: 187664 07:36:09 INFO - Running post-run listener: _upload_blobber_files 07:36:09 INFO - Blob upload gear active. 07:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:09 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 07:36:09 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'] 07:36:09 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 07:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:13 INFO - (blobuploader) - INFO - Done attempting. 07:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:14 INFO - (blobuploader) - INFO - Done attempting. 07:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:15 INFO - (blobuploader) - INFO - Done attempting. 07:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:15 INFO - (blobuploader) - INFO - Done attempting. 07:36:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:15 INFO - Return code: 0 07:36:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a116668a446a25ca241c17bd1d0f7121112dfe44dfb575704702ca2371ede01cb37d5d674270629c83b134439abf4bd234527b53b5f1c84e0fdbe08e7e5912ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b55f6c51eb82f0e94713dc53b9dd25ad37f3608149a97c0c31d4dccad2c6066270855a8cab9fb89c6d5311331f9c59bc19b4b0c6605030b522f980898fdd491", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1e28bd93ffe126c731fbaa496e7b335bbc323e1bee199123b7155d055236ec55c3d2dc4cb9d0fbc6cd1af20025dd2cd81cfd5759c9648a10f80352d4ad1bb31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db8a9b555dda3225ee46ea47a8425be415608dd6a3a5983f873f710c72070f45c1f96054a8ddf920fed0ec663cbaf95effe1fa3443396cbb0bbf59144fe287f"} 07:36:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:15 INFO - Contents: 07:36:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a116668a446a25ca241c17bd1d0f7121112dfe44dfb575704702ca2371ede01cb37d5d674270629c83b134439abf4bd234527b53b5f1c84e0fdbe08e7e5912ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b55f6c51eb82f0e94713dc53b9dd25ad37f3608149a97c0c31d4dccad2c6066270855a8cab9fb89c6d5311331f9c59bc19b4b0c6605030b522f980898fdd491", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1e28bd93ffe126c731fbaa496e7b335bbc323e1bee199123b7155d055236ec55c3d2dc4cb9d0fbc6cd1af20025dd2cd81cfd5759c9648a10f80352d4ad1bb31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db8a9b555dda3225ee46ea47a8425be415608dd6a3a5983f873f710c72070f45c1f96054a8ddf920fed0ec663cbaf95effe1fa3443396cbb0bbf59144fe287f"} 07:36:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:15 INFO - Copying logs to upload dir... 07:36:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.392335 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-29 07:36:15.899999) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:36:15.903700) ========= 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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a116668a446a25ca241c17bd1d0f7121112dfe44dfb575704702ca2371ede01cb37d5d674270629c83b134439abf4bd234527b53b5f1c84e0fdbe08e7e5912ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b55f6c51eb82f0e94713dc53b9dd25ad37f3608149a97c0c31d4dccad2c6066270855a8cab9fb89c6d5311331f9c59bc19b4b0c6605030b522f980898fdd491", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1e28bd93ffe126c731fbaa496e7b335bbc323e1bee199123b7155d055236ec55c3d2dc4cb9d0fbc6cd1af20025dd2cd81cfd5759c9648a10f80352d4ad1bb31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db8a9b555dda3225ee46ea47a8425be415608dd6a3a5983f873f710c72070f45c1f96054a8ddf920fed0ec663cbaf95effe1fa3443396cbb0bbf59144fe287f"} build_url:https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a116668a446a25ca241c17bd1d0f7121112dfe44dfb575704702ca2371ede01cb37d5d674270629c83b134439abf4bd234527b53b5f1c84e0fdbe08e7e5912ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b55f6c51eb82f0e94713dc53b9dd25ad37f3608149a97c0c31d4dccad2c6066270855a8cab9fb89c6d5311331f9c59bc19b4b0c6605030b522f980898fdd491", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1e28bd93ffe126c731fbaa496e7b335bbc323e1bee199123b7155d055236ec55c3d2dc4cb9d0fbc6cd1af20025dd2cd81cfd5759c9648a10f80352d4ad1bb31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2db8a9b555dda3225ee46ea47a8425be415608dd6a3a5983f873f710c72070f45c1f96054a8ddf920fed0ec663cbaf95effe1fa3443396cbb0bbf59144fe287f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:36:15.929929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:36:15.930342) ========= 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=eca2ab57546de7b41f256b19000001ef-1490796908.829403-1085359591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:36:16.015330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:36:16.016095) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:36:16.016768) ========= ========= Total master_lag: 0.17 =========