builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1490651430.78 results: success (0) revision: a6f35285bd1e674553527873614c55e0b7366bdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.784416) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.784876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.785164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.800442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.800851) ========= 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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-27 14:50:31-- 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% 42.5M=0s 2017-03-27 14:50:31 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147976 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.963382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:30.963732) ========= 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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:31.014797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 14:50:31.015369) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a6f35285bd1e674553527873614c55e0b7366bdb --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 a6f35285bd1e674553527873614c55e0b7366bdb --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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-27 14:50:31,379 truncating revision to first 12 chars 2017-03-27 14:50:31,379 Setting DEBUG logging. 2017-03-27 14:50:31,379 attempt 1/10 2017-03-27 14:50:31,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a6f35285bd1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 14:50:33,053 unpacking tar archive at: mozilla-central-a6f35285bd1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.995190 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-27 14:50:33.024825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:33.025165) ========= script_repo_revision: a6f35285bd1e674553527873614c55e0b7366bdb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:33.025542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:33.025804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 14:50:33.035014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-27 14:50:33.035390) ========= /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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:50:33 INFO - MultiFileLogger online at 20170327 14:50:33 in /builds/slave/test 14:50:33 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 14:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:33 INFO - {'append_to_log': False, 14:50:33 INFO - 'base_work_dir': '/builds/slave/test', 14:50:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:33 INFO - 'branch': 'Firefox-Non-PGO', 14:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:33 INFO - 'config_files': ('talos/linux_config.py',), 14:50:33 INFO - 'default_actions': ('clobber', 14:50:33 INFO - 'read-buildbot-config', 14:50:33 INFO - 'download-and-extract', 14:50:33 INFO - 'populate-webroot', 14:50:33 INFO - 'create-virtualenv', 14:50:33 INFO - 'install', 14:50:33 INFO - 'run-tests'), 14:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:33 INFO - 'download_minidump_stackwalk': True, 14:50:33 INFO - 'download_symbols': 'ondemand', 14:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:33 INFO - 'gecko_profile': False, 14:50:33 INFO - 'gecko_profile_interval': 0, 14:50:33 INFO - 'installer_path': 'installer.exe', 14:50:33 INFO - 'log_level': 'info', 14:50:33 INFO - 'log_name': 'talos', 14:50:33 INFO - 'log_to_console': True, 14:50:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:50:33 INFO - 'opt_config_files': (), 14:50:33 INFO - 'pip_index': False, 14:50:33 INFO - 'suite': 'dromaeojs-e10s', 14:50:33 INFO - 'system_bits': '32', 14:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:33 INFO - 'title': 'talos-linux64-ix-083', 14:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:33 INFO - 'use_talos_json': True, 14:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:33 INFO - 'work_dir': 'build'} 14:50:33 INFO - [mozharness: 2017-03-27 21:50:33.497498Z] Running clobber step. 14:50:33 INFO - Running pre-action listener: _resource_record_pre_action 14:50:33 INFO - Running main action method: clobber 14:50:33 INFO - rmtree: /builds/slave/test/build 14:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:34 INFO - Running post-action listener: _resource_record_post_action 14:50:34 INFO - [mozharness: 2017-03-27 21:50:34.433397Z] Finished clobber step (success) 14:50:34 INFO - [mozharness: 2017-03-27 21:50:34.433498Z] Running read-buildbot-config step. 14:50:34 INFO - Running pre-action listener: _resource_record_pre_action 14:50:34 INFO - Running main action method: read_buildbot_config 14:50:34 INFO - Using buildbot properties: 14:50:34 INFO - { 14:50:34 INFO - "project": "", 14:50:34 INFO - "product": "firefox", 14:50:34 INFO - "who": "kwierso@gmail.com", 14:50:34 INFO - "installer_path": "public/build/target.tar.bz2", 14:50:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:50:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:50:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:50:34 INFO - "stage_platform": "linux64", 14:50:34 INFO - "basedir": "/builds/slave/test", 14:50:34 INFO - "buildnumber": 773, 14:50:34 INFO - "platform": "ubuntu64_hw", 14:50:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:50:34 INFO - "slavebuilddir": "test", 14:50:34 INFO - "taskId": "e6HEMQBQSK2yDR77y4radg", 14:50:34 INFO - "branch": "mozilla-central", 14:50:34 INFO - "script_repo_revision": "production", 14:50:34 INFO - "revision": "a6f35285bd1e674553527873614c55e0b7366bdb", 14:50:34 INFO - "slavename": "talos-linux64-ix-083", 14:50:34 INFO - "repo_path": "mozilla-central" 14:50:34 INFO - } 14:50:34 INFO - Finding installer, test and symbols from parent task. 14:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6HEMQBQSK2yDR77y4radg'}, attempt #1 14:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6HEMQBQSK2yDR77y4radg'}, attempt #1 14:50:35 INFO - Task dependencies: Ghl18wyVRBmTNDHD1aOwbQ 14:50:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ'}, attempt #1 14:50:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 14:50:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/test_packages.json 14:50:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.crashreporter-symbols.zip 14:50:35 INFO - Running post-action listener: _resource_record_post_action 14:50:35 INFO - [mozharness: 2017-03-27 21:50:35.865267Z] Finished read-buildbot-config step (success) 14:50:35 INFO - [mozharness: 2017-03-27 21:50:35.865486Z] Running download-and-extract step. 14:50:35 INFO - Running pre-action listener: _resource_record_pre_action 14:50:35 INFO - Running main action method: download_and_extract 14:50:35 INFO - mkdir: /builds/slave/test/build/tests 14:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:35 INFO - trying https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.test_packages.json 14:50:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:50:36 INFO - Downloaded 986 bytes. 14:50:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:50:36 INFO - Using the following test package requirements: 14:50:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:50:36 INFO - u'common': [u'target.common.tests.zip'], 14:50:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:50:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:50:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:50:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:50:36 INFO - u'mozbase': [u'target.common.tests.zip'], 14:50:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:50:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:50:36 INFO - u'web-platform': [u'target.common.tests.zip', 14:50:36 INFO - u'target.web-platform.tests.zip'], 14:50:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:50:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:50:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip 14:50:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:50:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip into memory 14:50:37 INFO - Expected file size: 58132639 14:50:37 INFO - Obtained file size: 58132639 14:50:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:50:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip 14:50:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:50:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.common.tests.zip into memory 14:50:48 INFO - Expected file size: 58132639 14:50:48 INFO - Obtained file size: 58132639 14:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.talos.tests.zip 14:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.talos.tests.zip into memory 14:51:00 INFO - Expected file size: 14404171 14:51:00 INFO - Obtained file size: 14404171 14:51: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')]} 14:51:00 INFO - trying https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 14:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:51:01 INFO - Downloaded 62505020 bytes. 14:51:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 14:51:01 INFO - mkdir: /builds/slave/test/properties 14:51:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:01 INFO - Contents: 14:51:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 14:51:01 INFO - Running post-action listener: _resource_record_post_action 14:51:01 INFO - Running post-action listener: set_extra_try_arguments 14:51:01 INFO - [mozharness: 2017-03-27 21:51:01.465711Z] Finished download-and-extract step (success) 14:51:01 INFO - [mozharness: 2017-03-27 21:51:01.465814Z] Running populate-webroot step. 14:51:01 INFO - Running pre-action listener: _resource_record_pre_action 14:51:01 INFO - Running main action method: populate_webroot 14:51:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:01 INFO - '--tppagecycles', 14:51:01 INFO - '7'], 14:51:01 INFO - 'tests': ['tsvgm']}}, 14:51:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['damp', 'tps']}, 14:51:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'tests': ['damp', 'tps']}, 14:51:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['dromaeo_dom']}, 14:51:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['basic_compositor_video']}, 14:51:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['a11yr', 14:51:01 INFO - 'ts_paint', 14:51:01 INFO - 'tpaint', 14:51:01 INFO - 'sessionrestore', 14:51:01 INFO - 'sessionrestore_no_auto_restore', 14:51:01 INFO - 'tabpaint']}, 14:51:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['tsvgx', 14:51:01 INFO - 'tsvgr_opacity', 14:51:01 INFO - 'tart', 14:51:01 INFO - 'tscrollx', 14:51:01 INFO - 'cart', 14:51:01 INFO - 'tsvg_static']}, 14:51:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:01 INFO - 'tsvgr_opacity', 14:51:01 INFO - 'tart', 14:51:01 INFO - 'tscrollx', 14:51:01 INFO - 'cart', 14:51:01 INFO - 'tsvg_static']}, 14:51:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'talos_options': ['--disable-e10s'], 14:51:01 INFO - 'tests': ['tp5o']}, 14:51:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:51:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'talos_options': ['--disable-e10s', 14:51:01 INFO - '--xperf_path', 14:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:01 INFO - 'tests': ['tp5n']}, 14:51:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:51:01 INFO - 'talos_options': ['--xperf_path', 14:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:01 INFO - 'tests': ['tp5n']}}, 14:51:01 INFO - 'talos.zip': {'path': '', 14:51:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:01 INFO - Running post-action listener: _resource_record_post_action 14:51:01 INFO - [mozharness: 2017-03-27 21:51:01.478915Z] Finished populate-webroot step (success) 14:51:01 INFO - [mozharness: 2017-03-27 21:51:01.479005Z] Running create-virtualenv step. 14:51:01 INFO - Running pre-action listener: _resource_record_pre_action 14:51:01 INFO - Running main action method: create_virtualenv 14:51:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:01 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 14:51:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:01 INFO - Using real prefix '/usr' 14:51:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:04 INFO - Installing pip.................done. 14:51:04 INFO - Return code: 0 14:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:51:04 INFO - Reading from file tmpfile_stdout 14:51:04 INFO - Output received: 14:51:04 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) 14:51:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51: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', 'pip>=1.5'] in /builds/slave/test/build 14:51: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 pip>=1.5 14:51:04 INFO - Using env: {'DISPLAY': ':0', 14:51:04 INFO - 'HOME': '/home/cltbld', 14:51:04 INFO - 'LANG': 'en_US.UTF-8', 14:51:04 INFO - 'LANGUAGE': 'en_US:en', 14:51:04 INFO - 'LOGNAME': 'cltbld', 14:51:04 INFO - 'MAIL': '/var/mail/cltbld', 14:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:04 INFO - 'MOZ_NO_REMOTE': '1', 14:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:04 INFO - 'NO_EM_RESTART': '1', 14:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:04 INFO - 'PWD': '/builds/slave/test', 14:51:04 INFO - 'SHELL': '/bin/bash', 14:51:04 INFO - 'SHLVL': '1', 14:51:04 INFO - 'TERM': 'linux', 14:51:04 INFO - 'TMOUT': '86400', 14:51:04 INFO - 'USER': 'cltbld', 14:51:04 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:04 INFO - '_': '/tools/buildbot/bin/python'} 14:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:04 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 14:51:04 INFO - Cleaning up... 14:51:04 INFO - Return code: 0 14:51:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', '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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:51: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 psutil>=3.1.1 14:51:04 INFO - Using env: {'DISPLAY': ':0', 14:51:04 INFO - 'HOME': '/home/cltbld', 14:51:04 INFO - 'LANG': 'en_US.UTF-8', 14:51:04 INFO - 'LANGUAGE': 'en_US:en', 14:51:04 INFO - 'LOGNAME': 'cltbld', 14:51:04 INFO - 'MAIL': '/var/mail/cltbld', 14:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:04 INFO - 'MOZ_NO_REMOTE': '1', 14:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:04 INFO - 'NO_EM_RESTART': '1', 14:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:04 INFO - 'PWD': '/builds/slave/test', 14:51:04 INFO - 'SHELL': '/bin/bash', 14:51:04 INFO - 'SHLVL': '1', 14:51:04 INFO - 'TERM': 'linux', 14:51:04 INFO - 'TMOUT': '86400', 14:51:04 INFO - 'USER': 'cltbld', 14:51:04 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:04 INFO - '_': '/tools/buildbot/bin/python'} 14:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:04 INFO - Downloading/unpacking psutil>=3.1.1 14:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:06 INFO - Installing collected packages: psutil 14:51:06 INFO - Running setup.py install for psutil 14:51:06 INFO - building 'psutil._psutil_linux' extension 14:51:06 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 14:51:07 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 14:51:07 INFO - building 'psutil._psutil_posix' extension 14:51:07 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 14:51:07 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 14:51:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:07 INFO - Successfully installed psutil 14:51:07 INFO - Cleaning up... 14:51:07 INFO - Return code: 0 14:51:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:51:07 INFO - Using env: {'DISPLAY': ':0', 14:51:07 INFO - 'HOME': '/home/cltbld', 14:51:07 INFO - 'LANG': 'en_US.UTF-8', 14:51:07 INFO - 'LANGUAGE': 'en_US:en', 14:51:07 INFO - 'LOGNAME': 'cltbld', 14:51:07 INFO - 'MAIL': '/var/mail/cltbld', 14:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:07 INFO - 'MOZ_NO_REMOTE': '1', 14:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:07 INFO - 'NO_EM_RESTART': '1', 14:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:07 INFO - 'PWD': '/builds/slave/test', 14:51:07 INFO - 'SHELL': '/bin/bash', 14:51:07 INFO - 'SHLVL': '1', 14:51:07 INFO - 'TERM': 'linux', 14:51:07 INFO - 'TMOUT': '86400', 14:51:07 INFO - 'USER': 'cltbld', 14:51:07 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:07 INFO - '_': '/tools/buildbot/bin/python'} 14:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51:07 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 14:51:07 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 14:51:07 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 14:51:07 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 14:51:07 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 14:51:07 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 14:51:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:51:09 INFO - Installing collected packages: mozsystemmonitor 14:51:09 INFO - Running setup.py install for mozsystemmonitor 14:51:09 INFO - Successfully installed mozsystemmonitor 14:51:09 INFO - Cleaning up... 14:51:09 INFO - Return code: 0 14:51:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:51:09 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')]} 14:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:09 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')]} 14:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:09 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:09 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 14:51:09 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 14:51:09 INFO - Using env: {'DISPLAY': ':0', 14:51:09 INFO - 'HOME': '/home/cltbld', 14:51:09 INFO - 'LANG': 'en_US.UTF-8', 14:51:09 INFO - 'LANGUAGE': 'en_US:en', 14:51:09 INFO - 'LOGNAME': 'cltbld', 14:51:09 INFO - 'MAIL': '/var/mail/cltbld', 14:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:09 INFO - 'MOZ_NO_REMOTE': '1', 14:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:09 INFO - 'NO_EM_RESTART': '1', 14:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:09 INFO - 'PWD': '/builds/slave/test', 14:51:09 INFO - 'SHELL': '/bin/bash', 14:51:09 INFO - 'SHLVL': '1', 14:51:09 INFO - 'TERM': 'linux', 14:51:09 INFO - 'TMOUT': '86400', 14:51:09 INFO - 'USER': 'cltbld', 14:51:09 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:09 INFO - '_': '/tools/buildbot/bin/python'} 14:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:51:10 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 14:51:10 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 14:51:10 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 14:51:10 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 14:51:10 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 14:51:10 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 14:51:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:12 INFO - warning: no files found matching '*.txt' 14:51:12 INFO - no previously-included directories found matching 'build' 14:51:12 INFO - no previously-included directories found matching 'dist' 14:51:12 INFO - no previously-included directories found matching '.git*' 14:51:12 INFO - Installing collected packages: jsonschema, functools32 14:51:12 INFO - Running setup.py install for functools32 14:51:12 INFO - warning: no files found matching '*.txt' 14:51:12 INFO - no previously-included directories found matching 'build' 14:51:12 INFO - no previously-included directories found matching 'dist' 14:51:12 INFO - no previously-included directories found matching '.git*' 14:51:12 INFO - Successfully installed jsonschema functools32 14:51:12 INFO - Cleaning up... 14:51:12 INFO - Return code: 0 14:51:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:12 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:12 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 14:51:12 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 14:51:12 INFO - Using env: {'DISPLAY': ':0', 14:51:12 INFO - 'HOME': '/home/cltbld', 14:51:12 INFO - 'LANG': 'en_US.UTF-8', 14:51:12 INFO - 'LANGUAGE': 'en_US:en', 14:51:12 INFO - 'LOGNAME': 'cltbld', 14:51:12 INFO - 'MAIL': '/var/mail/cltbld', 14:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:12 INFO - 'MOZ_NO_REMOTE': '1', 14:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:12 INFO - 'NO_EM_RESTART': '1', 14:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:12 INFO - 'PWD': '/builds/slave/test', 14:51:12 INFO - 'SHELL': '/bin/bash', 14:51:12 INFO - 'SHLVL': '1', 14:51:12 INFO - 'TERM': 'linux', 14:51:12 INFO - 'TMOUT': '86400', 14:51:12 INFO - 'USER': 'cltbld', 14:51:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:12 INFO - '_': '/tools/buildbot/bin/python'} 14:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:51:12 INFO - Cleaning up... 14:51:12 INFO - Return code: 0 14:51:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:12 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:12 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 14:51:12 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 14:51:12 INFO - Using env: {'DISPLAY': ':0', 14:51:12 INFO - 'HOME': '/home/cltbld', 14:51:12 INFO - 'LANG': 'en_US.UTF-8', 14:51:12 INFO - 'LANGUAGE': 'en_US:en', 14:51:12 INFO - 'LOGNAME': 'cltbld', 14:51:12 INFO - 'MAIL': '/var/mail/cltbld', 14:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:12 INFO - 'MOZ_NO_REMOTE': '1', 14:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:12 INFO - 'NO_EM_RESTART': '1', 14:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:12 INFO - 'PWD': '/builds/slave/test', 14:51:12 INFO - 'SHELL': '/bin/bash', 14:51:12 INFO - 'SHLVL': '1', 14:51:12 INFO - 'TERM': 'linux', 14:51:12 INFO - 'TMOUT': '86400', 14:51:12 INFO - 'USER': 'cltbld', 14:51:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:12 INFO - '_': '/tools/buildbot/bin/python'} 14:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:12 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 14:51:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 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 14:51:15 INFO - Downloading docopt-0.6.1.tar.gz 14:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:15 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:15 INFO - Running setup.py install for blobuploader 14:51:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:15 INFO - Running setup.py install for requests 14:51:16 INFO - Running setup.py install for docopt 14:51:16 INFO - Successfully installed blobuploader requests docopt 14:51:16 INFO - Cleaning up... 14:51:16 INFO - Return code: 0 14:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:16 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:16 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 14:51:16 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 14:51:16 INFO - Using env: {'DISPLAY': ':0', 14:51:16 INFO - 'HOME': '/home/cltbld', 14:51:16 INFO - 'LANG': 'en_US.UTF-8', 14:51:16 INFO - 'LANGUAGE': 'en_US:en', 14:51:16 INFO - 'LOGNAME': 'cltbld', 14:51:16 INFO - 'MAIL': '/var/mail/cltbld', 14:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:16 INFO - 'MOZ_NO_REMOTE': '1', 14:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:16 INFO - 'NO_EM_RESTART': '1', 14:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:16 INFO - 'PWD': '/builds/slave/test', 14:51:16 INFO - 'SHELL': '/bin/bash', 14:51:16 INFO - 'SHLVL': '1', 14:51:16 INFO - 'TERM': 'linux', 14:51:16 INFO - 'TMOUT': '86400', 14:51:16 INFO - 'USER': 'cltbld', 14:51:16 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:16 INFO - '_': '/tools/buildbot/bin/python'} 14:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:16 INFO - Running setup.py (path:/tmp/pip-VJXF3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:16 INFO - Running setup.py (path:/tmp/pip-m5pDGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:16 INFO - Running setup.py (path:/tmp/pip-fE70Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:16 INFO - Running setup.py (path:/tmp/pip-bGDfty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:16 INFO - Running setup.py (path:/tmp/pip-sOLh6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:16 INFO - Running setup.py (path:/tmp/pip-UtDKun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:17 INFO - Running setup.py (path:/tmp/pip-Y8_mZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:17 INFO - Running setup.py (path:/tmp/pip-f9fI4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:17 INFO - Running setup.py (path:/tmp/pip-veHIc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:17 INFO - Running setup.py (path:/tmp/pip-Md03B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:17 INFO - Running setup.py (path:/tmp/pip-qzYHOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:17 INFO - Running setup.py (path:/tmp/pip-7amnH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:17 INFO - Running setup.py (path:/tmp/pip-WKHGIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:17 INFO - Running setup.py (path:/tmp/pip-dHK6oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:17 INFO - Running setup.py (path:/tmp/pip-54hhQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:17 INFO - Running setup.py (path:/tmp/pip-N3aYNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:17 INFO - Running setup.py (path:/tmp/pip-dDYvXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:17 INFO - Running setup.py install for manifestparser 14:51:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:17 INFO - Running setup.py install for mozcrash 14:51:18 INFO - Running setup.py install for mozdebug 14:51:18 INFO - Running setup.py install for mozdevice 14:51:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for mozfile 14:51:18 INFO - Running setup.py install for mozhttpd 14:51:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for mozinfo 14:51:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for mozInstall 14:51:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for mozleak 14:51:18 INFO - Running setup.py install for mozlog 14:51:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for moznetwork 14:51:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:18 INFO - Running setup.py install for mozprocess 14:51:19 INFO - Running setup.py install for mozprofile 14:51:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:19 INFO - Running setup.py install for mozrunner 14:51:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:19 INFO - Running setup.py install for mozscreenshot 14:51:19 INFO - Running setup.py install for moztest 14:51:19 INFO - Running setup.py install for mozversion 14:51:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:19 INFO - Cleaning up... 14:51:19 INFO - Return code: 0 14:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:19 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:19 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 14:51:19 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 14:51:19 INFO - Using env: {'DISPLAY': ':0', 14:51:19 INFO - 'HOME': '/home/cltbld', 14:51:19 INFO - 'LANG': 'en_US.UTF-8', 14:51:19 INFO - 'LANGUAGE': 'en_US:en', 14:51:19 INFO - 'LOGNAME': 'cltbld', 14:51:19 INFO - 'MAIL': '/var/mail/cltbld', 14:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:19 INFO - 'MOZ_NO_REMOTE': '1', 14:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:19 INFO - 'NO_EM_RESTART': '1', 14:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:19 INFO - 'PWD': '/builds/slave/test', 14:51:19 INFO - 'SHELL': '/bin/bash', 14:51:19 INFO - 'SHLVL': '1', 14:51:19 INFO - 'TERM': 'linux', 14:51:19 INFO - 'TMOUT': '86400', 14:51:19 INFO - 'USER': 'cltbld', 14:51:19 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:19 INFO - '_': '/tools/buildbot/bin/python'} 14:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:19 INFO - Running setup.py (path:/tmp/pip-mS09cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:19 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)) 14:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:19 INFO - Running setup.py (path:/tmp/pip-WMR2Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:20 INFO - Running setup.py (path:/tmp/pip-hVSfsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:20 INFO - Running setup.py (path:/tmp/pip-v8E_G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:20 INFO - Running setup.py (path:/tmp/pip-VTIQOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:20 INFO - Running setup.py (path:/tmp/pip-esNqKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:20 INFO - Running setup.py (path:/tmp/pip-D3fCF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:20 INFO - Running setup.py (path:/tmp/pip-MyRLMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:20 INFO - Running setup.py (path:/tmp/pip-BsnK8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:20 INFO - Running setup.py (path:/tmp/pip-1MMUWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:20 INFO - Running setup.py (path:/tmp/pip-7LpTml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:20 INFO - Running setup.py (path:/tmp/pip-d91lf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:20 INFO - Running setup.py (path:/tmp/pip-Uj3M1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:20 INFO - Running setup.py (path:/tmp/pip-zN1Lnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:20 INFO - Running setup.py (path:/tmp/pip-csZPdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:20 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)) 14:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:20 INFO - Running setup.py (path:/tmp/pip-WI42kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:21 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)) 14:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:21 INFO - Running setup.py (path:/tmp/pip-_qt2zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:21 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)) 14:51:21 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)) 14:51:21 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)) 14:51:21 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)) 14:51:21 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)) 14:51:21 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)) 14:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:23 INFO - Downloading blessings-1.6.tar.gz 14:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:23 INFO - Installing collected packages: blessings 14:51:23 INFO - Running setup.py install for blessings 14:51:23 INFO - Successfully installed blessings 14:51:23 INFO - Cleaning up... 14:51:23 INFO - Return code: 0 14:51:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:23 INFO - Reading from file tmpfile_stdout 14:51:23 INFO - Current package versions: 14:51:23 INFO - argparse == 1.2.1 14:51:23 INFO - blessings == 1.6 14:51:23 INFO - blobuploader == 1.2.4 14:51:23 INFO - docopt == 0.6.1 14:51:23 INFO - functools32 == 3.2.3-2 14:51:23 INFO - jsonschema == 2.5.1 14:51:23 INFO - manifestparser == 1.1 14:51:23 INFO - mozInstall == 1.12 14:51:23 INFO - mozcrash == 1.0 14:51:23 INFO - mozdebug == 0.1 14:51:23 INFO - mozdevice == 0.49 14:51:23 INFO - mozfile == 1.2 14:51:23 INFO - mozhttpd == 0.7 14:51:23 INFO - mozinfo == 0.9 14:51:23 INFO - mozleak == 0.1 14:51:23 INFO - mozlog == 3.4 14:51:23 INFO - moznetwork == 0.27 14:51:23 INFO - mozprocess == 0.25 14:51:23 INFO - mozprofile == 0.28 14:51:23 INFO - mozrunner == 6.13 14:51:23 INFO - mozscreenshot == 0.1 14:51:23 INFO - mozsystemmonitor == 0.3 14:51:23 INFO - moztest == 0.8 14:51:23 INFO - mozversion == 1.4 14:51:23 INFO - psutil == 3.1.1 14:51:23 INFO - requests == 1.2.3 14:51:23 INFO - wsgiref == 0.1.2 14:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:23 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:23 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 14:51:23 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 14:51:23 INFO - Using env: {'DISPLAY': ':0', 14:51:23 INFO - 'HOME': '/home/cltbld', 14:51:23 INFO - 'LANG': 'en_US.UTF-8', 14:51:23 INFO - 'LANGUAGE': 'en_US:en', 14:51:23 INFO - 'LOGNAME': 'cltbld', 14:51:23 INFO - 'MAIL': '/var/mail/cltbld', 14:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:23 INFO - 'MOZ_NO_REMOTE': '1', 14:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:23 INFO - 'NO_EM_RESTART': '1', 14:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:23 INFO - 'PWD': '/builds/slave/test', 14:51:23 INFO - 'SHELL': '/bin/bash', 14:51:23 INFO - 'SHLVL': '1', 14:51:23 INFO - 'TERM': 'linux', 14:51:23 INFO - 'TMOUT': '86400', 14:51:23 INFO - 'USER': 'cltbld', 14:51:23 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:23 INFO - '_': '/tools/buildbot/bin/python'} 14:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 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)) 14:51:23 INFO - Cleaning up... 14:51:23 INFO - Return code: 0 14:51:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:23 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 0x18131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, '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': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', '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 14:51:23 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 14:51:23 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 14:51:23 INFO - Using env: {'DISPLAY': ':0', 14:51:23 INFO - 'HOME': '/home/cltbld', 14:51:23 INFO - 'LANG': 'en_US.UTF-8', 14:51:23 INFO - 'LANGUAGE': 'en_US:en', 14:51:23 INFO - 'LOGNAME': 'cltbld', 14:51:23 INFO - 'MAIL': '/var/mail/cltbld', 14:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:23 INFO - 'MOZ_NO_REMOTE': '1', 14:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:23 INFO - 'NO_EM_RESTART': '1', 14:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:23 INFO - 'PWD': '/builds/slave/test', 14:51:23 INFO - 'SHELL': '/bin/bash', 14:51:23 INFO - 'SHLVL': '1', 14:51:23 INFO - 'TERM': 'linux', 14:51:23 INFO - 'TMOUT': '86400', 14:51:23 INFO - 'USER': 'cltbld', 14:51:23 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:23 INFO - '_': '/tools/buildbot/bin/python'} 14:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:24 INFO - Cleaning up... 14:51:24 INFO - Return code: 0 14:51:24 INFO - Running post-action listener: _resource_record_post_action 14:51:24 INFO - Running post-action listener: _start_resource_monitoring 14:51:24 INFO - Starting resource monitoring. 14:51:24 INFO - [mozharness: 2017-03-27 21:51:24.076854Z] Finished create-virtualenv step (success) 14:51:24 INFO - [mozharness: 2017-03-27 21:51:24.077370Z] Running install step. 14:51:24 INFO - Running pre-action listener: _resource_record_pre_action 14:51:24 INFO - Running main action method: install 14:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:24 INFO - Reading from file tmpfile_stdout 14:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:24 INFO - Reading from file tmpfile_stdout 14:51:24 INFO - Output received: 14:51:24 INFO - Usage: mozinstall [options] installer 14:51:24 INFO - Options: 14:51:24 INFO - -h, --help show this help message and exit 14:51:24 INFO - -d DEST, --destination=DEST 14:51:24 INFO - Directory to install application into. [default: 14:51:24 INFO - "/builds/slave/test"] 14:51:24 INFO - --app=APP Application being installed. [default: firefox] 14:51:24 INFO - mkdir: /builds/slave/test/build/application 14:51:24 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'] 14:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:51:40 INFO - Reading from file tmpfile_stdout 14:51:40 INFO - Output received: 14:51:40 INFO - /builds/slave/test/build/application/firefox/firefox 14:51:40 INFO - Running post-action listener: _resource_record_post_action 14:51:40 INFO - [mozharness: 2017-03-27 21:51:40.264782Z] Finished install step (success) 14:51:40 INFO - [mozharness: 2017-03-27 21:51:40.265057Z] Running run-tests step. 14:51:40 INFO - Running pre-action listener: _resource_record_pre_action 14:51:40 INFO - Running main action method: run_tests 14:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:51:40 INFO - Python 2.7.3 14:51:40 INFO - Return code: 0 14:51:40 INFO - grabbing minidump binary from tooltool 14:51: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')]} 14:51:40 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 0x1aae290>, '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 0x1aaeb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:51:40 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 14:51:40 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 14:51:40 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 14:51:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:51:40 INFO - Return code: 0 14:51:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:51:40 INFO - ENV: RUST_BACKTRACE is now 1 14:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:51:40 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/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 14:51:40 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/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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 14:51:40 INFO - Using env: {'DISPLAY': ':0', 14:51:40 INFO - 'HOME': '/home/cltbld', 14:51:40 INFO - 'LANG': 'en_US.UTF-8', 14:51:40 INFO - 'LANGUAGE': 'en_US:en', 14:51:40 INFO - 'LOGNAME': 'cltbld', 14:51:40 INFO - 'MAIL': '/var/mail/cltbld', 14:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:40 INFO - 'MOZ_NO_REMOTE': '1', 14:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:40 INFO - 'NO_EM_RESTART': '1', 14:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:40 INFO - 'PWD': '/builds/slave/test', 14:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:51:40 INFO - 'RUST_BACKTRACE': '1', 14:51:40 INFO - 'SHELL': '/bin/bash', 14:51:40 INFO - 'SHLVL': '1', 14:51:40 INFO - 'TERM': 'linux', 14:51:40 INFO - 'TMOUT': '86400', 14:51:40 INFO - 'USER': 'cltbld', 14:51:40 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324', 14:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:40 INFO - '_': '/tools/buildbot/bin/python'} 14:51:40 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/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 14:51:40 INFO - mozversion application_buildid: 20170327212148 14:51:40 INFO - mozversion application_changeset: a6f35285bd1e674553527873614c55e0b7366bdb 14:51:40 INFO - mozversion application_display_name: Nightly 14:51:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:51:40 INFO - mozversion application_name: Firefox 14:51:40 INFO - mozversion application_remotingname: firefox 14:51:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:51:40 INFO - mozversion application_vendor: Mozilla 14:51:40 INFO - mozversion application_version: 55.0a1 14:51:40 INFO - mozversion platform_buildid: 20170327212148 14:51:40 INFO - mozversion platform_changeset: a6f35285bd1e674553527873614c55e0b7366bdb 14:51:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:51:40 INFO - mozversion platform_version: 55.0a1 14:51:40 INFO - using testdate: 1490651500 14:51:40 INFO - actual date: 1490651500 14:51:40 INFO - starting webserver on 'localhost:49469' 14:51:40 INFO - SUITE-START | Running 2 tests 14:51:40 INFO - TEST-START | dromaeo_css 14:51:40 INFO - operating with platform_type : linux_ 14:51:40 INFO - Initialising browser for dromaeo_css test... 14:51:40 INFO - TEST-INFO | started process 12832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUzjln4/profile http://localhost:49469/getInfo.html) 14:51:45 INFO - PID 12832 | __metrics Screen width/height:1600/1200 14:51:45 INFO - PID 12832 | colorDepth:24 14:51:45 INFO - PID 12832 | Browser inner width/height: 1024/697 14:51:45 INFO - PID 12832 | __metrics 14:51:45 ERROR - PID 12832 | 1490651505991 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/tmpUzjln4/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpUzjln4/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpUzjln4/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpUzjln4/profile/extensions/talos-powers@TalosPowersService.js:55:9 14:51:46 ERROR - PID 12832 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 14:51:47 INFO - TEST-INFO | 12832: exit 0 14:51:47 INFO - Browser initialized. 14:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:51:47 INFO - TEST-INFO | started process 12961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUzjln4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:59 INFO - PID 12961 | RSS: Main: 155418624 14:51:59 INFO - PID 12961 | 14:55:03 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49469/tests/dromaeo/cssquery-ext.html) 14:55:06 INFO - PID 12961 | RSS: Main: 165494784 14:55:06 INFO - PID 12961 | 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | A coding exception was thrown and uncaught in a Task. 14:56:47 INFO - PID 12961 | 14:56:47 ERROR - PID 12961 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:56:47 INFO - PID 12961 | Full stack: 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | A coding exception was thrown and uncaught in a Task. 14:56:47 INFO - PID 12961 | 14:56:47 ERROR - PID 12961 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:56:47 INFO - PID 12961 | Full stack: 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | A coding exception was thrown and uncaught in a Task. 14:56:47 INFO - PID 12961 | 14:56:47 ERROR - PID 12961 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:56:47 INFO - PID 12961 | Full stack: 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | ************************* 14:56:47 INFO - PID 12961 | A coding exception was thrown and uncaught in a Task. 14:56:47 INFO - PID 12961 | 14:56:47 ERROR - PID 12961 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:56:47 INFO - PID 12961 | Full stack: 14:56:47 INFO - PID 12961 | ************************* 14:58:09 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-ext.html (next: http://localhost:49469/tests/dromaeo/cssquery-jquery.html) 14:58:09 INFO - PID 12961 | RSS: Main: 160976896 14:58:09 INFO - PID 12961 | 15:01:11 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49469/tests/dromaeo/cssquery-mootools.html) 15:01:12 INFO - PID 12961 | RSS: Main: 169517056 15:01:12 INFO - PID 12961 | 15:04:14 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49469/tests/dromaeo/cssquery-prototype.html) 15:04:14 INFO - PID 12961 | RSS: Main: 161800192 15:04:14 INFO - PID 12961 | 15:07:17 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49469/tests/dromaeo/cssquery-yui.html) 15:07:18 INFO - PID 12961 | RSS: Main: 168255488 15:07:18 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | Cycle 1(1): loaded http://localhost:49469/tests/dromaeo/cssquery-yui.html (next: http://localhost:49469/tests/dromaeo/cssquery-dojo.html) 15:10:21 INFO - PID 12961 | RSS: Main: 161857536 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | __start_tp_report 15:10:21 INFO - PID 12961 | _x_x_mozilla_page_load 15:10:21 INFO - PID 12961 | _x_x_mozilla_page_load_details 15:10:21 INFO - PID 12961 | |i|pagename|runs| 15:10:21 INFO - PID 12961 | |0;dojo.html;2713.9185824425267;2735.220462168282;2739.6438462999818;2767.8754456049487;2780.388314570794;5284.075286824809;5354.9196762048605;5414.485623865731;5446;5450.209719590657;5344.599155063376;5376.435474275204;5387.272718183044;5456.772226249092;5486.506214440699;4867.904721437666;4902.411710594733;4918.877028074309;4974.930389966156;4990.87522811929;4964.925526117111;4979.352684151056;5019.824306149286;5024.949750502485;5037.697738135724;4723.220668589679;4761.476237613894;4889.046635906;4960.305557221992;4992.226204938241;4886.975565122151;4919.065377578285;4929.457759646436;4970.7017578945015;4989.101961646902;4802.471728109905;4850.029994001214;4872.309985394039;4899.828506002273;4906.460289368167;5152.92270615941;5203.947960520384;5368.32895888014;5402.594805389612;5419.403865574823;5743.770249190027;5789.392113828072;5831.125331200312;5835.883282334372;5841.970790146022;5846.444587764156;5856.238688970449;5857.121431785224;5865.413458654143;5866.794662186803;5186.351706036746;5409.756560954766;5419.132938729785;5420.566354691615;5427.185922111676;5808;5888.9705551472825;5958.165856780054;5974.193483879708;6022.7289771959495;5494.615376923657;5510.91733623996;5691.943080569141;5692.686902220335;5751.712414379264;5701.287339082614;5789.044807606782;5791.536677065825;5816.098504731774;5852.8536786579825;5537.280153580009;5739.454751798572;5753.453421924911;5761.308642962871;5770.336411312669;5573.5819813514145;5605.355384130796;5695.487406133468;5737.51231145349;5757.337906140764;4952.603791696655;4957.281194226817;4957.380327459067;4974.0797952378925;5001.349824522788;4172.374143878443;4172.624463798273;4196.664266858644;4197.265478541243;4235.110626768352;4778.354922085544;4825.638077144228;4909.926351104737;4988.351514303117;5000.124978128885;5828.737706803204;5848.3274423441;5877.941220587825;5895.29256489224;5936.168936348915;4932.802687892516;4965.677230979974;4971.850844474599;4987.850364488999;5023.397192336943;4994.22589498621;5031.094403007347;5243.737813109406;5250.527452529291;5253.973730131325;5260.789568417374;5264.15773476242;5272.499112584298;5277.102892508206;5289.100852854947;5640.633358831663;5644.774209031592;5651.4348565143155;5651.886962260814;5658.264425624642;5256.448072952285;5264.52619264268;5266.947330526646;5268.657537260219;5274.8945021100135;5531.948929703343;5576.693281869536;5581.302337207849;5585.720713964204;5620.381758006534;5701.315842098975;5708.343540492897;5713.971430142823;5714.314282286152;5714.514266287246;5525.336959564878;5539.030669632879;5541.6120871540215;5549.306336707911;5703.372629010722;5743;5752.050911599539;5752.511036561772;5753.654780713171;5764.884702305846;5585.413531579288;5593.496585307342;5668.7165641718575;5675.460831221192;5676.2337084493065;5431.755570999236;5483.698396588226;5662.292213473316;5673.120666296731;5688.40271771458;5481.0408178567795;5494.066008778437;5499.670019798825;5510.972445137749;5544.417836127149 15:10:21 INFO - PID 12961 | |1;ext.html;728.0608015659798;749.3518106837587;1058.2697938422489;1075.688050465365;1166.4809159923827;31059.223519411997;32213.83893080534;32274.838625806897;32368.202677437766;32445.837770811173;30103.397932041345;30442.847785761096;30552;30582.694173058262;30583.541246881316;6776.728930842761;6913.066735990652;6946.47901407394;7260.927390726104;7488.588127652977;6725.495587830907;7608;7612.7335543255995;7629.2752188542;7646.579438130901;7606.961965190167;7776.066871975371;7781.027371578552;7789.2210778921935;7793.649285782153;7660.693572257103;7709.845803083963;7745.573993430359;7748.225177482235;7762.146163921964;7537.057867766529;7561.054868141482;7562.962185189039;7578.242175782378;7598;33876.83061584701;34289;34407.13982150441;34416.6558334416;34581.82709086464;2595.156574113402;2610.5040042391884;2612.8824202910914;2614.3202767280454;2686.4492778980457;23605.527889442114;23684.881575592182;23984.52030959371;24165.637515437284;24625;2952.158634789096;2964.303388703653;2965.1993961630237;2966.391889662614;2972.4203780262856;149113;149973;150826.24586876994;151003.48996510005;151227;31935.520967185512;32327.51508727371;37441.43837842435;42074.15851682949;42391;39434.21131577352;39456.80271598681;39537.20925581472;39703.80148099241;39760.60239397627;12444.81332780009;12481.126321157431;12574.119811613282;12579.93710031444;12585.119041666996;9849.113579777855;9879.654212102541;9897.455639939872;9923.255755818342;9948.45283509414;12782.424790884432;12802.423890924745;12866;12902.35488225585;13058.412371443308;5362.758675859518;5437.891242175135;5528.530074943595;5578.358488773762;5590.161475778585;874.2481465939287;875.2516598308482;898.766320756608;906.3927168796922;920.4385324951774;20084.196632134845;21094.261700840398;21104.261350852645;21186.470338241357;21533.67699484509;976.4678250353575;981.215027977615;988.461288597716;1005.6781829814389;1005.7636455432968;13010.934945325213;13800.171989680652;14052;14086.506972256127;14140.15159090458;229223;229922;231651;232330;232516;44205.55794442079;44359.77820110879;44670.32994505085;44731.99999999935;44853.77573112114;1222;1251.2429979862234;1261.1991385470292;1265.1080987903506;1280.750253700538;23960.88019559891;24204.062540431136;25192.37019074538;25235;25405;30864.845675771478;30877.0736877894;31093.222669433446;31165.220869478446;31230.37539249157;243121;243759;244275;244405;244430;27547.586786197822;28036.158915232576;28058.71941280561;28334.574981375707;28548.14355569336;31723;32260.35479290448;32837.17907052343;32856.83571582222;35416.822915885255;25944;26516.602250966636;26985.73014269832;27396.315092122855;27417.725822742315;26351.341216468976;26510.602340965288;26564.601530977438;27578.310542236606;27627.44745105127;29145.271368215963;29535.85232073826;29696.851515742284;29920.551191731705;30019.54970675398;24647.753522464547;25351.6197257045;26335.868320658275;26670.866645666647;27156.592651110645;19827.801721982596;21380.251691191355;21486.67769983483;21861.344159675235;22005 15:10:21 INFO - PID 12961 | |2;jquery.html;411.29052384636486;416.87077006128084;425.08606496033525;425.2197218104778;438.50010987474286;14454.710905781878;17039.31842726291;17691.82308176918;17774.400303972623;18112.81887181128;17534;18527.814721852777;18734.906325468386;18788.71816922744;18934.90532547335;5479.287692599956;5566.638168519054;5641.52047075997;5667.546596272309;5688.345840228365;5584.385717571064;5589.524890384322;5594.300712410949;5610.803621873235;5612.550995920316;5523.696196709179;5554.472325129126;5668.404817494165;5685.147227915804;5705.258316418881;5544.833654990357;5581.553475721932;5602.187682786014;5603.271574695264;5604.271444712182;5071.239314102877;5112.335396398482;5136.178211486144;5140.640155189139;5153.123968925292;22369.888150559305;22474.32577022692;22759;22926.426839328982;23241;1595.5293188509418;1602.1268408717276;1608.3807734022369;1655.1972293437673;1655.21377345761;13525.661858453519;14210.715785684331;14284.928575357057;14384.208868512227;14912;1680.3782600437794;1694.805097413801;1710.144927536232;1715.6482921001289;1725.1805392438616;84790.57604711999;86754;86799.56600217022;87004.56497717534;87851;10294.639687610897;10508.796481407499;10523.263371563917;10619.893801062046;10733;14448.566543003726;14461.13233206011;14494.927525362305;14539.255289365132;14548;7787.182345853717;7828.530288182727;7960.960195198987;7984.4810087345295;8003.719869804645;7364.484486086029;7376.852462950818;7379.631018449056;7608.391328693802;7617.428692848059;6816;6892.862142757217;6917.412019978257;6970.198427180838;7098.148222213367;1921.68292231783;1935.090507461491;1944.8346890514465;1982.415187519685;2358.0214211102543;856.1737922904427;871.4771137317558;874.7213508809587;887.2369762004671;909.8771665825029;16933.32266709318;17080.743788843178;17715.73426398605;17837;18054.368097116538;889.1775108025051;892.8839250897341;894.217559635319;897.6678628907346;911.7401540560908;9306.72079837606;9468.479233642216;9772.804543909082;9784.168345690696;9903;389439;394711;398945;400876;408538;83172;86449.56775216083;86799;87296.563517182;89167.10832891718;1081.8160912644712;1092.7541303206874;1117.8546788917552;1118.9776204475866;1121.6354684727332;14854.180168503175;14916.925415372854;15127.697446050797;15189.240537973279;15317.089752946904;41975.370369445096;42483.57516424796;42689.786551067045;42788.57211427846;43683.56316436795;48922;50073.74963125307;51377;51738.482615173365;55066;7297.379722723628;7483.625818708934;7527.397808175442;7528.510646808159;7593.974813400341;11644.068474522188;11747.236429632047;11840.585579504675;11944.581939632071;12190.57332993341;10157.644482443078;10205.795884082425;10271.332363396356;10363.222758293008;10728;8644.092370301028;8714.651413943624;9102.13529714676;9155.587998540215;9336.906630933603;9484.85772713396;9579.377340472847;9881.802363952824;10440.269181157246;10646.148308135176;7370.078740157481;7410.296021877913;7476.102867655699;7585.848283034198;7766.805829854299;9528.618855245713;9850.226959147136;10032.64885728996;10264.230182736474;10379.481025948522 15:10:21 INFO - PID 12961 | |3;mootools.html;1250.5560526013267;1269.7650934577098;1311.980320295195;1312.7965165399366;1317.0714646174447;9448.622055117796;9737.074977877099;9744.951275243622;9889.752756181098;10135.49322533874;9453.858192127123;9543.713688589336;9575.904240957605;9597.568109435075;9602.327837051409;2257.1761307122906;2282.8471621830954;2292.6446400807818;2300.194931773874;2306.273523839985;2075.543380456305;2133.797289257518;2252.560750653623;2261.276391554695;2263.7283525976904;2144.635411979967;2187.9890600546973;2223.966640500386;2238.932832015034;2243.798058174764;2154.2352464874903;2194.133317339642;2198.0987795004053;2203.206845535614;2212.7787221277904;1790.2838864454193;1852.7498787663628;2131.5097527568746;2209.9116035358566;2225.788550087755;9658.30979578571;9747.853782193273;9749.805003899883;9782.804343913082;9785.11933925943;5444.265024221719;5644.3508996465525;5647.576431767593;5666.1784041314195;5675.744591493392;3300.1914530939835;3318;3410.334984677989;3424.2434839953826;3456.2569047654624;1012.6759436980169;1025.9538320775582;1048.2400259811652;1054.8206804843119;1075.4622688655672;14641.34113964874;14700.338484768212;14716.632084197981;14800.777988330183;14830.62923426923;4747.842341804871;4761.071591039783;4853.538913803183;4871.902561948812;5018.623603229772;10273.589056437659;10320;10335.896641033643;10348.430836303925;10374.325668831501;5456.590755693339;5480.287562616834;5532.336119665666;5547.16792481123;5550.389457159709;4982.825601104017;5106.795728170906;5189.506996835295;5226.320578324793;5264.236685680631;3562.87529936451;3571.1072231942017;3628.9274214515563;3686.760360576554;3729.086373838427;1076.1175835814556;1099.6371197504805;1106.164845541611;1115.3029356652091;1119.0879433261866;673.1316601584;693.4071368979551;697.8115908704622;705.428602831708;714.3570786292379;4916.70499770015;5025.120603894304;5035.823746168867;5040.2691609716385;5114.897702045938;551.5863102672995;567.9602427830013;575.5539456920836;577.4831525784399;583.1398686936734;3468.687818096333;3488.2500262443696;3496.59789124254;3508.8421021054114;3584.444411116281;12440.564580239829;13182.934085329513;13190.076694631283;13205.273709945854;13223.471061157446;12734.299613521345;12893.419796109198;13023.153495022983;13081.345932703327;13116.672083197805;9311.441313521345;9357.766055848522;9408.106229908148;9453.810923781486;9475.05249475047;5440.564754819684;5539.224508568885;5601.41185175567;5620.8875822482505;5675.68783716883;11582.942264822772;11607.535698571963;11642.883571164519;11655.358955257543;11765.823512647146;11051.889481105407;11236.719082023015;12027.338496382434;12079.335636539723;12133;7925.0886148093705;7995.800104997189;8112.310453611273;8113.229243221885;8117.228863257981;8802;8953.865692014755;8968.820623587622;9203.907960920305;9204.171624553823;7276.272372762893;7387.372073373824;7471.066116735408;7556.1310449299035;7622.656980435783;7571.432142589218;7714.652840622298;7758.88361674564;7853.803654908673;7902.841943161219;6601.53789234749;6762.526623136333;6778.288279730557;6797.048413222054;6804.76183333581;5189.6886186828915;5192.896142077213;5275.788968441219;5320.467953204648;5522;5202.635815492879;5281.762320695655;5287.947120528899;5360.410354860885;5388.326459192601 15:10:21 INFO - PID 12961 | |4;prototype.html;383.8829157107083;408.40373055339205;410.57710558125143;412.0378915232929;418.61696547658886;5511.641743286694;5604.271444712187;5613.522850557702;5671.1776792365135;5700.486956173943;5448.237246785443;5531.751071201796;5557.916631250535;5562.9443705562935;5579.972100139494;4302.20409224293;4305.440292761944;4319.848805291816;4326.178026175033;4330.956690433087;4153.626173644371;4270.7864606769535;4320.783960801963;4330.350447432878;4343.283358245885;4248.596383343577;4263.12605915788;4267.935980960288;4268.103698223377;4282.421873047146;4271.67962402821;4276.957230427687;4279.807408666617;4285.571442855705;4287.063361597316;3570.428731402963;3759.1917737686254;3783.6027217142355;3784.678302344304;3785.5646600641003;5386.272853164812;5394.838154855361;5402.459754024605;5419.647722897999;5441.374241962146;4913.329467980903;4921.950780492185;4925.926111108336;4932.040775534686;4943.961768028718;5538.643032457034;5780.161876527922;5830;5841.153032810261;5859.736311865976;4129.752214867118;4135.8966025849295;4137.420761093449;4140.8136633851245;4154.252234597771;5729.914051289193;5962.850928726773;5999.610025348382;6151.446369826693;6229.813105606839;4189.120284740177;4211.473565804275;4231.386448964883;4232.576742325743;4238.008136175992;4267.8079486423185;4278.358246263086;4301.505326887448;4307.763073030951;4312.870613881589;4785.976070119627;4903.950960490421;4913.108453245526;4921.360223170965;4927.841957140069;5875.823725288248;5885.997521685295;5897.64614123154;5905.143754155623;5924.229850119457;1470.4706305729928;1484.9554513364617;1488.6576087499936;1488.7097016081977;1490.9776353354707;966.5457235099492;998.6904059741504;1007.7050989478631;1013.4426065663855;1024.948752562369;5073.8731531712;5105.285260063594;5153.330067091254;5156.664816786897;5165.870853228625;6047.667378294148;6048.697565121726;6053.757849685963;6060.636361818305;6075.574709770273;4883.389576302962;5102.413222479388;5111.693298402108;5116.923246151311;5152.124138896396;3197.7921435106646;3228.806271623663;3236.271838836243;3241.0276916924827;3256.3812875553567;5515.531179849678;5654.257685022761;5676.432356764373;5677.006523858308;5680.204771331934;6189.288231853305;6193.256809182927;6222.439980401786;6233.724690487939;6235.532335074888;5634.74643641029;5645.774169033275;5648.152777083388;5648.604597678123;5668.433156684381;5837.803250333756;6011.639301641915;6030.698465076641;6067.757289708362;6088.208532890696;6040.033594624839;6048.334683184934;6069.302030266399;6072.271327440735;6074.362191969956;5393.973030134981;5473.671579705071;5557.444255574572;5612.943870561242;5673.574481913791;4203.537610862863;4203.97898010508;4231.984323762336;4240.173166232555;4240.660747140283;5932.1694962706115;6095.969520152371;6098.878022439615;6100.847478813065;6105.603135796159;5854.180414742024;5872.119182122716;5916.970415147896;5919.171316015675;5938.346781854079;5869.618474799125;5874.676892770939;5876.911846322394;5885.970570147293;5888.263967004124;5637.408072152365;5795.449432303924;5819.5635327351465;5832.270966129234;5832.825015249549;5854.590178687451;5915.858898770792;5924.437178468039;5950.137230101697;5959.080050775003;5596.888062238651;5722.370539240764;5729.367130367992;5744.396838331915;5753.71231438418 15:10:21 INFO - PID 12961 | |5;yui.html;685.4721864164591;689.0559932891939;691.4572060932169;711.2496316386214;720.4524561333388;12729.681757956045;12867.742645147091;13104.737905241902;13295.7340853183;13479.595612131652;12650.304233267167;12806.423710933008;12877.098603097787;12888.484460621565;13457.125286856348;824.3940703582847;849.864021756519;861.7802460372596;863.6977058029702;864.127231496187;816.8121332093622;839.5550358310074;846.9576521173948;867.6616119713285;868.7524055644143;903.4895284164459;904.416651259937;906.7733066733317;913.0413066280412;913.2602591900549;895.4000819450983;896.8206358728248;903.169084442318;903.7514683462035;905.2124651553191;662.8376047868303;663.3399767231588;663.8506336074345;669.0165456778528;671.6843083750679;13012.609621711365;13062.281574513492;13121.737565248737;13169.078164528486;14625.122492650475;13330.200187988752;13824.930875345659;14051.929740351336;14110;14276.930459951056;10038.297319187659;10313.690589282334;10515.263931524796;10684.145268378512;10695.946520267427;2708.444768822387;2742.780577553791;2742.9862850685818;2758.8620568971473;2770.8060435769503;61772.691136544476;62076;62817.68591157015;62929.37070629281;63107.368926310606;10333.948330258301;10445.164386849034;10473.162147028219;10567.63013294531;10699.465026748632;21160.682589761167;21205.78794212069;21432.464188395414;21458;21524.56950860974;6281.905771413432;6473.870522589522;6570.671466426755;6579.605223686594;6770.119884415093;3319.7012268895915;3398.167448975017;3404.9489257661153;3407.4548072308808;3466.739994500372;3707.4994875691978;3750.643688849555;3756.962430375716;3776.169242766587;3829.9808500957315;662.867426514699;665.1087542692718;666.2804171494774;679.7518905599519;684.2234064337014;494.26107968587195;513.7354262554712;517.4747631154381;527.8442859356499;528.4983323601292;8117.269445749911;8173.7139200128895;8201.630926608197;8367.623456944451;8494.575271236414;502.7084291111147;507.5482820289945;519.7323378460096;524.8320537428062;526.2553486816189;3519.4544845548467;3524.646115365627;3555.235624340779;3564.590072141737;3637.1089083174793;60131.699341503016;61794;61819;64087.67956160189;64709.67645161744;55675.44324556783;56090.719546402004;56343.71828140833;57285;57513.42486575081;48909.266361004615;49197.754011229714;49351.25973110406;50267.24599131016;50310.496895030585;7139.714411423693;7247.927520724726;7281;7355.080614923135;7370.787410973569;25464.595159844488;25532.872335638946;25858.87070564635;26408.603870941566;27071.323216919736;31990.200244994063;32001.359972800878;32065.519017214294;32846;32919.17702057372;9864.901350986398;10057.346272492558;10177.49112544355;10237.181025517792;10636.361818290927;10637.627683031056;10670.679879603624;10785.946070269598;10997.12023038139;11065.059469944823;9589.904100958902;10370.27408081427;10378.532966016699;10423.478826058516;10794.298370605886;9767.951160244153;10021.448820314952;10148.695539133838;10538.998795114452;10558.947205263925;9309.44143351401;9791.853122203314;9847.704568862946;10160.593576256866;10263.332883362558;7231.385332246818;7282.235365286569;7410.629468526445;7589.5066820658685;7702.040328365275;7187.281271872771;7524.435667325082;7942.801429964066;8164.591770411337;8330.791730206793 15:10:21 INFO - PID 12961 | __end_tp_report 15:10:21 INFO - PID 12961 | __start_cc_report 15:10:21 INFO - PID 12961 | _x_x_mozilla_cycle_collect,404 15:10:21 INFO - PID 12961 | __end_cc_report 15:10:21 INFO - PID 12961 | __startTimestamp1490652621744__endTimestamp 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | ------- Summary: start ------- 15:10:21 INFO - PID 12961 | Number of tests: 6 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#0] dojo.html Cycles:165 Average:5298.41 Median:5446.00 stddev:601.32 (11.0%) stddev-sans-first:567.96 15:10:21 INFO - PID 12961 | Values: 2713.9 2735.2 2739.6 2767.9 2780.4 5284.1 5354.9 5414.5 5446.0 5450.2 5344.6 5376.4 5387.3 5456.8 5486.5 4867.9 4902.4 4918.9 4974.9 4990.9 4964.9 4979.4 5019.8 5024.9 5037.7 4723.2 4761.5 4889.0 4960.3 4992.2 4887.0 4919.1 4929.5 4970.7 4989.1 4802.5 4850.0 4872.3 4899.8 4906.5 5152.9 5203.9 5368.3 5402.6 5419.4 5743.8 5789.4 5831.1 5835.9 5842.0 5846.4 5856.2 5857.1 5865.4 5866.8 5186.4 5409.8 5419.1 5420.6 5427.2 5808.0 5889.0 5958.2 5974.2 6022.7 5494.6 5510.9 5691.9 5692.7 5751.7 5701.3 5789.0 5791.5 5816.1 5852.9 5537.3 5739.5 5753.5 5761.3 5770.3 5573.6 5605.4 5695.5 5737.5 5757.3 4952.6 4957.3 4957.4 4974.1 5001.3 4172.4 4172.6 4196.7 4197.3 4235.1 4778.4 4825.6 4909.9 4988.4 5000.1 5828.7 5848.3 5877.9 5895.3 5936.2 4932.8 4965.7 4971.9 4987.9 5023.4 4994.2 5031.1 5243.7 5250.5 5254.0 5260.8 5264.2 5272.5 5277.1 5289.1 5640.6 5644.8 5651.4 5651.9 5658.3 5256.4 5264.5 5266.9 5268.7 5274.9 5531.9 5576.7 5581.3 5585.7 5620.4 5701.3 5708.3 5714.0 5714.3 5714.5 5525.3 5539.0 5541.6 5549.3 5703.4 5743.0 5752.1 5752.5 5753.7 5764.9 5585.4 5593.5 5668.7 5675.5 5676.2 5431.8 5483.7 5662.3 5673.1 5688.4 5481.0 5494.1 5499.7 5511.0 5544.4 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#1] ext.html Cycles:180 Average:34400.66 Median:16331.62 stddev:55421.59 (339.4%) stddev-sans-first:55519.39 15:10:21 INFO - PID 12961 | Values: 728.1 749.4 1058.3 1075.7 1166.5 31059.2 32213.8 32274.8 32368.2 32445.8 30103.4 30442.8 30552.0 30582.7 30583.5 6776.7 6913.1 6946.5 7260.9 7488.6 6725.5 7608.0 7612.7 7629.3 7646.6 7607.0 7776.1 7781.0 7789.2 7793.6 7660.7 7709.8 7745.6 7748.2 7762.1 7537.1 7561.1 7563.0 7578.2 7598.0 33876.8 34289.0 34407.1 34416.7 34581.8 2595.2 2610.5 2612.9 2614.3 2686.4 23605.5 23684.9 23984.5 24165.6 24625.0 2952.2 2964.3 2965.2 2966.4 2972.4 149113.0 149973.0 150826.2 151003.5 151227.0 31935.5 32327.5 37441.4 42074.2 42391.0 39434.2 39456.8 39537.2 39703.8 39760.6 12444.8 12481.1 12574.1 12579.9 12585.1 9849.1 9879.7 9897.5 9923.3 9948.5 12782.4 12802.4 12866.0 12902.4 13058.4 5362.8 5437.9 5528.5 5578.4 5590.2 874.2 875.3 898.8 906.4 920.4 20084.2 21094.3 21104.3 21186.5 21533.7 976.5 981.2 988.5 1005.7 1005.8 13010.9 13800.2 14052.0 14086.5 14140.2 229223.0 229922.0 231651.0 232330.0 232516.0 44205.6 44359.8 44670.3 44732.0 44853.8 1222.0 1251.2 1261.2 1265.1 1280.8 23960.9 24204.1 25192.4 25235.0 25405.0 30864.8 30877.1 31093.2 31165.2 31230.4 243121.0 243759.0 244275.0 244405.0 244430.0 27547.6 28036.2 28058.7 28334.6 28548.1 31723.0 32260.4 32837.2 32856.8 35416.8 25944.0 26516.6 26985.7 27396.3 27417.7 26351.3 26510.6 26564.6 27578.3 27627.4 29145.3 29535.9 29696.9 29920.6 30019.5 24647.8 25351.6 26335.9 26670.9 27156.6 19827.8 21380.3 21486.7 21861.3 22005.0 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#2] jquery.html Cycles:180 Average:25846.26 Median:49497.87 stddev:66339.99 (134.0%) stddev-sans-first:66498.61 15:10:21 INFO - PID 12961 | Values: 411.3 416.9 425.1 425.2 438.5 14454.7 17039.3 17691.8 17774.4 18112.8 17534.0 18527.8 18734.9 18788.7 18934.9 5479.3 5566.6 5641.5 5667.5 5688.3 5584.4 5589.5 5594.3 5610.8 5612.6 5523.7 5554.5 5668.4 5685.1 5705.3 5544.8 5581.6 5602.2 5603.3 5604.3 5071.2 5112.3 5136.2 5140.6 5153.1 22369.9 22474.3 22759.0 22926.4 23241.0 1595.5 1602.1 1608.4 1655.2 1655.2 13525.7 14210.7 14284.9 14384.2 14912.0 1680.4 1694.8 1710.1 1715.6 1725.2 84790.6 86754.0 86799.6 87004.6 87851.0 10294.6 10508.8 10523.3 10619.9 10733.0 14448.6 14461.1 14494.9 14539.3 14548.0 7787.2 7828.5 7961.0 7984.5 8003.7 7364.5 7376.9 7379.6 7608.4 7617.4 6816.0 6892.9 6917.4 6970.2 7098.1 1921.7 1935.1 1944.8 1982.4 2358.0 856.2 871.5 874.7 887.2 909.9 16933.3 17080.7 17715.7 17837.0 18054.4 889.2 892.9 894.2 897.7 911.7 9306.7 9468.5 9772.8 9784.2 9903.0 389439.0 394711.0 398945.0 400876.0 408538.0 83172.0 86449.6 86799.0 87296.6 89167.1 1081.8 1092.8 1117.9 1119.0 1121.6 14854.2 14916.9 15127.7 15189.2 15317.1 41975.4 42483.6 42689.8 42788.6 43683.6 48922.0 50073.7 51377.0 51738.5 55066.0 7297.4 7483.6 7527.4 7528.5 7594.0 11644.1 11747.2 11840.6 11944.6 12190.6 10157.6 10205.8 10271.3 10363.2 10728.0 8644.1 8714.7 9102.1 9155.6 9336.9 9484.9 9579.4 9881.8 10440.3 10646.1 7370.1 7410.3 7476.1 7585.8 7766.8 9528.6 9850.2 10032.6 10264.2 10379.5 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#3] mootools.html Cycles:180 Average:6124.66 Median:4949.77 stddev:3933.43 (79.5%) stddev-sans-first:3927.41 15:10:21 INFO - PID 12961 | Values: 1250.6 1269.8 1312.0 1312.8 1317.1 9448.6 9737.1 9745.0 9889.8 10135.5 9453.9 9543.7 9575.9 9597.6 9602.3 2257.2 2282.8 2292.6 2300.2 2306.3 2075.5 2133.8 2252.6 2261.3 2263.7 2144.6 2188.0 2224.0 2238.9 2243.8 2154.2 2194.1 2198.1 2203.2 2212.8 1790.3 1852.7 2131.5 2209.9 2225.8 9658.3 9747.9 9749.8 9782.8 9785.1 5444.3 5644.4 5647.6 5666.2 5675.7 3300.2 3318.0 3410.3 3424.2 3456.3 1012.7 1026.0 1048.2 1054.8 1075.5 14641.3 14700.3 14716.6 14800.8 14830.6 4747.8 4761.1 4853.5 4871.9 5018.6 10273.6 10320.0 10335.9 10348.4 10374.3 5456.6 5480.3 5532.3 5547.2 5550.4 4982.8 5106.8 5189.5 5226.3 5264.2 3562.9 3571.1 3628.9 3686.8 3729.1 1076.1 1099.6 1106.2 1115.3 1119.1 673.1 693.4 697.8 705.4 714.4 4916.7 5025.1 5035.8 5040.3 5114.9 551.6 568.0 575.6 577.5 583.1 3468.7 3488.3 3496.6 3508.8 3584.4 12440.6 13182.9 13190.1 13205.3 13223.5 12734.3 12893.4 13023.2 13081.3 13116.7 9311.4 9357.8 9408.1 9453.8 9475.1 5440.6 5539.2 5601.4 5620.9 5675.7 11582.9 11607.5 11642.9 11655.4 11765.8 11051.9 11236.7 12027.3 12079.3 12133.0 7925.1 7995.8 8112.3 8113.2 8117.2 8802.0 8953.9 8968.8 9203.9 9204.2 7276.3 7387.4 7471.1 7556.1 7622.7 7571.4 7714.7 7758.9 7853.8 7902.8 6601.5 6762.5 6778.3 6797.0 6804.8 5189.7 5192.9 5275.8 5320.5 5522.0 5202.6 5281.8 5287.9 5360.4 5388.3 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#4] prototype.html Cycles:180 Average:4849.70 Median:5492.66 stddev:1416.19 (25.8%) stddev-sans-first:1379.93 15:10:21 INFO - PID 12961 | Values: 383.9 408.4 410.6 412.0 418.6 5511.6 5604.3 5613.5 5671.2 5700.5 5448.2 5531.8 5557.9 5562.9 5580.0 4302.2 4305.4 4319.8 4326.2 4331.0 4153.6 4270.8 4320.8 4330.4 4343.3 4248.6 4263.1 4267.9 4268.1 4282.4 4271.7 4277.0 4279.8 4285.6 4287.1 3570.4 3759.2 3783.6 3784.7 3785.6 5386.3 5394.8 5402.5 5419.6 5441.4 4913.3 4922.0 4925.9 4932.0 4944.0 5538.6 5780.2 5830.0 5841.2 5859.7 4129.8 4135.9 4137.4 4140.8 4154.3 5729.9 5962.9 5999.6 6151.4 6229.8 4189.1 4211.5 4231.4 4232.6 4238.0 4267.8 4278.4 4301.5 4307.8 4312.9 4786.0 4904.0 4913.1 4921.4 4927.8 5875.8 5886.0 5897.6 5905.1 5924.2 1470.5 1485.0 1488.7 1488.7 1491.0 966.5 998.7 1007.7 1013.4 1024.9 5073.9 5105.3 5153.3 5156.7 5165.9 6047.7 6048.7 6053.8 6060.6 6075.6 4883.4 5102.4 5111.7 5116.9 5152.1 3197.8 3228.8 3236.3 3241.0 3256.4 5515.5 5654.3 5676.4 5677.0 5680.2 6189.3 6193.3 6222.4 6233.7 6235.5 5634.7 5645.8 5648.2 5648.6 5668.4 5837.8 6011.6 6030.7 6067.8 6088.2 6040.0 6048.3 6069.3 6072.3 6074.4 5394.0 5473.7 5557.4 5612.9 5673.6 4203.5 4204.0 4232.0 4240.2 4240.7 5932.2 6096.0 6098.9 6100.8 6105.6 5854.2 5872.1 5917.0 5919.2 5938.3 5869.6 5874.7 5876.9 5886.0 5888.3 5637.4 5795.4 5819.6 5832.3 5832.8 5854.6 5915.9 5924.4 5950.1 5959.1 5596.9 5722.4 5729.4 5744.4 5753.7 15:10:21 INFO - PID 12961 | 15:10:21 INFO - PID 12961 | [#5] yui.html Cycles:180 Average:13726.48 Median:25409.02 stddev:17271.70 (68.0%) stddev-sans-first:17292.39 15:10:21 INFO - PID 12961 | Values: 685.5 689.1 691.5 711.2 720.5 12729.7 12867.7 13104.7 13295.7 13479.6 12650.3 12806.4 12877.1 12888.5 13457.1 824.4 849.9 861.8 863.7 864.1 816.8 839.6 847.0 867.7 868.8 903.5 904.4 906.8 913.0 913.3 895.4 896.8 903.2 903.8 905.2 662.8 663.3 663.9 669.0 671.7 13012.6 13062.3 13121.7 13169.1 14625.1 13330.2 13824.9 14051.9 14110.0 14276.9 10038.3 10313.7 10515.3 10684.1 10695.9 2708.4 2742.8 2743.0 2758.9 2770.8 61772.7 62076.0 62817.7 62929.4 63107.4 10333.9 10445.2 10473.2 10567.6 10699.5 21160.7 21205.8 21432.5 21458.0 21524.6 6281.9 6473.9 6570.7 6579.6 6770.1 3319.7 3398.2 3404.9 3407.5 3466.7 3707.5 3750.6 3757.0 3776.2 3830.0 662.9 665.1 666.3 679.8 684.2 494.3 513.7 517.5 527.8 528.5 8117.3 8173.7 8201.6 8367.6 8494.6 502.7 507.5 519.7 524.8 526.3 3519.5 3524.6 3555.2 3564.6 3637.1 60131.7 61794.0 61819.0 64087.7 64709.7 55675.4 56090.7 56343.7 57285.0 57513.4 48909.3 49197.8 49351.3 50267.2 50310.5 7139.7 7247.9 7281.0 7355.1 7370.8 25464.6 25532.9 25858.9 26408.6 27071.3 31990.2 32001.4 32065.5 32846.0 32919.2 9864.9 10057.3 10177.5 10237.2 10636.4 10637.6 10670.7 10785.9 10997.1 11065.1 9589.9 10370.3 10378.5 10423.5 10794.3 9768.0 10021.4 10148.7 10539.0 10558.9 9309.4 9791.9 9847.7 10160.6 10263.3 7231.4 7282.2 7410.6 7589.5 7702.0 7187.3 7524.4 7942.8 8164.6 8330.8 15:10:21 INFO - PID 12961 | -------- Summary: end -------- 15:10:21 INFO - PID 12961 | 15:10:22 INFO - TEST-INFO | 12961: exit 0 15:10:22 INFO - TEST-OK | dromaeo_css | took 1122052ms 15:10:22 INFO - TEST-START | kraken 15:10:22 INFO - operating with platform_type : linux_ 15:10:22 INFO - Initialising browser for kraken test... 15:10:22 INFO - TEST-INFO | started process 13340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hOmdv/profile http://localhost:49469/getInfo.html) 15:10:27 INFO - PID 13340 | __metrics Screen width/height:1600/1200 15:10:27 INFO - PID 13340 | colorDepth:24 15:10:27 INFO - PID 13340 | Browser inner width/height: 1024/697 15:10:27 INFO - PID 13340 | __metrics 15:10:27 ERROR - PID 13340 | 1490652627849 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/tmp0hOmdv/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp0hOmdv/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp0hOmdv/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp0hOmdv/profile/extensions/talos-powers@TalosPowersService.js:55:9 15:10:27 ERROR - PID 13340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 15:10:28 INFO - TEST-INFO | 13340: exit 0 15:10:28 INFO - Browser initialized. 15:10:28 INFO - Running cycle 1/1 for kraken test... 15:10:28 INFO - TEST-INFO | started process 13470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hOmdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:40 INFO - PID 13470 | RSS: Main: 156286976 15:10:40 INFO - PID 13470 | 15:10:43 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49469/tests/kraken/driver.html?testName=audio-beat-detection) 15:10:44 INFO - PID 13470 | RSS: Main: 161591296 15:10:44 INFO - PID 13470 | 15:10:47 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49469/tests/kraken/driver.html?testName=audio-dft) 15:10:47 INFO - PID 13470 | RSS: Main: 161198080 15:10:47 INFO - PID 13470 | 15:10:50 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49469/tests/kraken/driver.html?testName=audio-fft) 15:10:51 INFO - PID 13470 | RSS: Main: 157827072 15:10:51 INFO - PID 13470 | 15:10:53 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49469/tests/kraken/driver.html?testName=audio-oscillator) 15:10:54 INFO - PID 13470 | RSS: Main: 158552064 15:10:54 INFO - PID 13470 | 15:10:56 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:10:57 INFO - PID 13470 | RSS: Main: 158953472 15:10:57 INFO - PID 13470 | 15:11:00 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49469/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:00 INFO - PID 13470 | RSS: Main: 163930112 15:11:00 INFO - PID 13470 | 15:11:04 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49469/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:05 INFO - PID 13470 | RSS: Main: 161030144 15:11:05 INFO - PID 13470 | 15:11:08 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49469/tests/kraken/driver.html?testName=json-parse-financial) 15:11:08 INFO - PID 13470 | RSS: Main: 162590720 15:11:08 INFO - PID 13470 | 15:11:10 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:11 INFO - PID 13470 | RSS: Main: 162824192 15:11:11 INFO - PID 13470 | 15:11:12 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:13 INFO - PID 13470 | RSS: Main: 162873344 15:11:13 INFO - PID 13470 | 15:11:15 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:16 INFO - PID 13470 | RSS: Main: 163360768 15:11:16 INFO - PID 13470 | 15:11:19 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:20 INFO - PID 13470 | RSS: Main: 163500032 15:11:20 INFO - PID 13470 | 15:11:23 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:23 INFO - PID 13470 | RSS: Main: 163794944 15:11:23 INFO - PID 13470 | 15:11:25 INFO - PID 13470 | Cycle 1(1): loaded http://localhost:49469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49469/tests/kraken/driver.html?testName=ai-astar) 15:11:26 INFO - PID 13470 | RSS: Main: 164917248 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | __start_tp_report 15:11:26 INFO - PID 13470 | _x_x_mozilla_page_load 15:11:26 INFO - PID 13470 | _x_x_mozilla_page_load_details 15:11:26 INFO - PID 13470 | |i|pagename|runs| 15:11:26 INFO - PID 13470 | |0;ai-astar;104;111;110;113;113;112;112;111;110;112 15:11:26 INFO - PID 13470 | |1;audio-beat-detection;152;123;125;186;125;126;125;126;156;127 15:11:26 INFO - PID 13470 | |2;audio-dft;163;171;164;171;167;170;163;165;163;163 15:11:26 INFO - PID 13470 | |3;audio-fft;75;75;76;111;76;78;76;75;91;78 15:11:26 INFO - PID 13470 | |4;audio-oscillator;86;85;104;88;87;86;108;84;85;107 15:11:26 INFO - PID 13470 | |5;imaging-gaussian-blur;114;115;113;113;115;113;116;114;114;115 15:11:26 INFO - PID 13470 | |6;imaging-darkroom;152;150;152;151;151;150;152;151;152;151 15:11:26 INFO - PID 13470 | |7;imaging-desaturate;94;96;95;95;95;95;94;95;94;95 15:11:26 INFO - PID 13470 | |8;json-parse-financial;70;70;69;70;77;69;72;71;70;70 15:11:26 INFO - PID 13470 | |9;json-stringify-tinderbox;55;56;56;55;56;55;56;55;56;57 15:11:26 INFO - PID 13470 | |10;stanford-crypto-aes;91;82;92;83;86;83;82;90;82;91 15:11:26 INFO - PID 13470 | |11;stanford-crypto-ccm;147;132;152;133;137;139;145;138;188;147 15:11:26 INFO - PID 13470 | |12;stanford-crypto-pbkdf2;189;212;193;187;194;193;205;193;197;197 15:11:26 INFO - PID 13470 | |13;stanford-crypto-sha256-iterative;73;73;76;71;77;70;73;70;70;70 15:11:26 INFO - PID 13470 | __end_tp_report 15:11:26 INFO - PID 13470 | __start_cc_report 15:11:26 INFO - PID 13470 | _x_x_mozilla_cycle_collect,880 15:11:26 INFO - PID 13470 | __end_cc_report 15:11:26 INFO - PID 13470 | __startTimestamp1490652686006__endTimestamp 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | ------- Summary: start ------- 15:11:26 INFO - PID 13470 | Number of tests: 14 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:1.13 15:11:26 INFO - PID 13470 | Values: 104.0 111.0 110.0 113.0 113.0 112.0 112.0 111.0 110.0 112.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:126.50 stddev:20.97 (16.6%) stddev-sans-first:21.54 15:11:26 INFO - PID 13470 | Values: 152.0 123.0 125.0 186.0 125.0 126.0 125.0 126.0 156.0 127.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:3.46 (2.1%) stddev-sans-first:3.50 15:11:26 INFO - PID 13470 | Values: 163.0 171.0 164.0 171.0 167.0 170.0 163.0 165.0 163.0 163.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.55 (15.2%) stddev-sans-first:12.04 15:11:26 INFO - PID 13470 | Values: 75.0 75.0 76.0 111.0 76.0 78.0 76.0 75.0 91.0 78.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.50 stddev:10.00 (11.7%) stddev-sans-first:10.37 15:11:26 INFO - PID 13470 | Values: 86.0 85.0 104.0 88.0 87.0 86.0 108.0 84.0 85.0 107.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:1.03 (0.9%) stddev-sans-first:1.09 15:11:26 INFO - PID 13470 | Values: 114.0 115.0 113.0 113.0 115.0 113.0 116.0 114.0 114.0 115.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 15:11:26 INFO - PID 13470 | Values: 152.0 150.0 152.0 151.0 151.0 150.0 152.0 151.0 152.0 151.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:11:26 INFO - PID 13470 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#8] json-parse-financial Cycles:10 Average:70.80 Median:70.00 stddev:2.35 (3.4%) stddev-sans-first:2.47 15:11:26 INFO - PID 13470 | Values: 70.0 70.0 69.0 70.0 77.0 69.0 72.0 71.0 70.0 70.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 15:11:26 INFO - PID 13470 | Values: 55.0 56.0 56.0 55.0 56.0 55.0 56.0 55.0 56.0 57.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:88.00 stddev:4.32 (4.9%) stddev-sans-first:4.21 15:11:26 INFO - PID 13470 | Values: 91.0 82.0 92.0 83.0 86.0 83.0 82.0 90.0 82.0 91.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:146.00 stddev:16.20 (11.1%) stddev-sans-first:17.18 15:11:26 INFO - PID 13470 | Values: 147.0 132.0 152.0 133.0 137.0 139.0 145.0 138.0 188.0 147.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.00 Median:195.50 stddev:7.45 (3.8%) stddev-sans-first:7.46 15:11:26 INFO - PID 13470 | Values: 189.0 212.0 193.0 187.0 194.0 193.0 205.0 193.0 197.0 197.0 15:11:26 INFO - PID 13470 | 15:11:26 INFO - PID 13470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:2.58 (3.5%) stddev-sans-first:2.73 15:11:26 INFO - PID 13470 | Values: 73.0 73.0 76.0 71.0 77.0 70.0 73.0 70.0 70.0 70.0 15:11:26 INFO - PID 13470 | -------- Summary: end -------- 15:11:26 INFO - PID 13470 | 15:11:27 INFO - TEST-INFO | 13470: exit 0 15:11:27 INFO - TEST-OK | kraken | took 64571ms 15:11:27 INFO - SUITE-END | took 1186s 15:11:27 INFO - Completed test suite (00:19:47) 15:11:27 INFO - javascript benchmark 15:11:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6611.000426878626, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.9185824425267, 2735.220462168282, 2739.6438462999818, 2767.8754456049487, 2780.388314570794, 5284.075286824809, 5354.9196762048605, 5414.485623865731, 5446.0, 5450.209719590657, 5344.599155063376, 5376.435474275204, 5387.272718183044, 5456.772226249092, 5486.506214440699, 4867.904721437666, 4902.411710594733, 4918.877028074309, 4974.930389966156, 4990.87522811929, 4964.925526117111, 4979.352684151056, 5019.824306149286, 5024.949750502485, 5037.697738135724, 4723.220668589679, 4761.476237613894, 4889.046635906, 4960.305557221992, 4992.226204938241, 4886.975565122151, 4919.065377578285, 4929.457759646436, 4970.7017578945015, 4989.101961646902, 4802.471728109905, 4850.029994001214, 4872.309985394039, 4899.828506002273, 4906.460289368167, 5152.92270615941, 5203.947960520384, 5368.32895888014, 5402.594805389612, 5419.403865574823, 5743.770249190027, 5789.392113828072, 5831.125331200312, 5835.883282334372, 5841.970790146022, 5846.444587764156, 5856.238688970449, 5857.121431785224, 5865.413458654143, 5866.794662186803, 5186.351706036746, 5409.756560954766, 5419.132938729785, 5420.566354691615, 5427.185922111676, 5808.0, 5888.9705551472825, 5958.165856780054, 5974.193483879708, 6022.7289771959495, 5494.615376923657, 5510.91733623996, 5691.943080569141, 5692.686902220335, 5751.712414379264, 5701.287339082614, 5789.044807606782, 5791.536677065825, 5816.098504731774, 5852.8536786579825, 5537.280153580009, 5739.454751798572, 5753.453421924911, 5761.308642962871, 5770.336411312669, 5573.5819813514145, 5605.355384130796, 5695.487406133468, 5737.51231145349, 5757.337906140764, 4952.603791696655, 4957.281194226817, 4957.380327459067, 4974.0797952378925, 5001.349824522788, 4172.374143878443, 4172.624463798273, 4196.664266858644, 4197.265478541243, 4235.110626768352, 4778.354922085544, 4825.638077144228, 4909.926351104737, 4988.351514303117, 5000.124978128885, 5828.737706803204, 5848.3274423441, 5877.941220587825, 5895.29256489224, 5936.168936348915, 4932.802687892516, 4965.677230979974, 4971.850844474599, 4987.850364488999, 5023.397192336943, 4994.22589498621, 5031.094403007347, 5243.737813109406, 5250.527452529291, 5253.973730131325, 5260.789568417374, 5264.15773476242, 5272.499112584298, 5277.102892508206, 5289.100852854947, 5640.633358831663, 5644.774209031592, 5651.4348565143155, 5651.886962260814, 5658.264425624642, 5256.448072952285, 5264.52619264268, 5266.947330526646, 5268.657537260219, 5274.8945021100135, 5531.948929703343, 5576.693281869536, 5581.302337207849, 5585.720713964204, 5620.381758006534, 5701.315842098975, 5708.343540492897, 5713.971430142823, 5714.314282286152, 5714.514266287246, 5525.336959564878, 5539.030669632879, 5541.6120871540215, 5549.306336707911, 5703.372629010722, 5743.0, 5752.050911599539, 5752.511036561772, 5753.654780713171, 5764.884702305846, 5585.413531579288, 5593.496585307342, 5668.7165641718575, 5675.460831221192, 5676.2337084493065, 5431.755570999236, 5483.698396588226, 5662.292213473316, 5673.120666296731, 5688.40271771458, 5481.0408178567795, 5494.066008778437, 5499.670019798825, 5510.972445137749, 5544.417836127149], "value": 5255.222674285486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.0608015659798, 749.3518106837587, 1058.2697938422489, 1075.688050465365, 1166.4809159923827, 31059.223519411997, 32213.83893080534, 32274.838625806897, 32368.202677437766, 32445.837770811173, 30103.397932041345, 30442.847785761096, 30552.0, 30582.694173058262, 30583.541246881316, 6776.728930842761, 6913.066735990652, 6946.47901407394, 7260.927390726104, 7488.588127652977, 6725.495587830907, 7608.0, 7612.7335543255995, 7629.2752188542, 7646.579438130901, 7606.961965190167, 7776.066871975371, 7781.027371578552, 7789.2210778921935, 7793.649285782153, 7660.693572257103, 7709.845803083963, 7745.573993430359, 7748.225177482235, 7762.146163921964, 7537.057867766529, 7561.054868141482, 7562.962185189039, 7578.242175782378, 7598.0, 33876.83061584701, 34289.0, 34407.13982150441, 34416.6558334416, 34581.82709086464, 2595.156574113402, 2610.5040042391884, 2612.8824202910914, 2614.3202767280454, 2686.4492778980457, 23605.527889442114, 23684.881575592182, 23984.52030959371, 24165.637515437284, 24625.0, 2952.158634789096, 2964.303388703653, 2965.1993961630237, 2966.391889662614, 2972.4203780262856, 149113.0, 149973.0, 150826.24586876994, 151003.48996510005, 151227.0, 31935.520967185512, 32327.51508727371, 37441.43837842435, 42074.15851682949, 42391.0, 39434.21131577352, 39456.80271598681, 39537.20925581472, 39703.80148099241, 39760.60239397627, 12444.81332780009, 12481.126321157431, 12574.119811613282, 12579.93710031444, 12585.119041666996, 9849.113579777855, 9879.654212102541, 9897.455639939872, 9923.255755818342, 9948.45283509414, 12782.424790884432, 12802.423890924745, 12866.0, 12902.35488225585, 13058.412371443308, 5362.758675859518, 5437.891242175135, 5528.530074943595, 5578.358488773762, 5590.161475778585, 874.2481465939287, 875.2516598308482, 898.766320756608, 906.3927168796922, 920.4385324951774, 20084.196632134845, 21094.261700840398, 21104.261350852645, 21186.470338241357, 21533.67699484509, 976.4678250353575, 981.215027977615, 988.461288597716, 1005.6781829814389, 1005.7636455432968, 13010.934945325213, 13800.171989680652, 14052.0, 14086.506972256127, 14140.15159090458, 229223.0, 229922.0, 231651.0, 232330.0, 232516.0, 44205.55794442079, 44359.77820110879, 44670.32994505085, 44731.99999999935, 44853.77573112114, 1222.0, 1251.2429979862234, 1261.1991385470292, 1265.1080987903506, 1280.750253700538, 23960.88019559891, 24204.062540431136, 25192.37019074538, 25235.0, 25405.0, 30864.845675771478, 30877.0736877894, 31093.222669433446, 31165.220869478446, 31230.37539249157, 243121.0, 243759.0, 244275.0, 244405.0, 244430.0, 27547.586786197822, 28036.158915232576, 28058.71941280561, 28334.574981375707, 28548.14355569336, 31723.0, 32260.35479290448, 32837.17907052343, 32856.83571582222, 35416.822915885255, 25944.0, 26516.602250966636, 26985.73014269832, 27396.315092122855, 27417.725822742315, 26351.341216468976, 26510.602340965288, 26564.601530977438, 27578.310542236606, 27627.44745105127, 29145.271368215963, 29535.85232073826, 29696.851515742284, 29920.551191731705, 30019.54970675398, 24647.753522464547, 25351.6197257045, 26335.868320658275, 26670.866645666647, 27156.592651110645, 19827.801721982596, 21380.251691191355, 21486.67769983483, 21861.344159675235, 22005.0], "value": 14948.633212360439, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.29052384636486, 416.87077006128084, 425.08606496033525, 425.2197218104778, 438.50010987474286, 14454.710905781878, 17039.31842726291, 17691.82308176918, 17774.400303972623, 18112.81887181128, 17534.0, 18527.814721852777, 18734.906325468386, 18788.71816922744, 18934.90532547335, 5479.287692599956, 5566.638168519054, 5641.52047075997, 5667.546596272309, 5688.345840228365, 5584.385717571064, 5589.524890384322, 5594.300712410949, 5610.803621873235, 5612.550995920316, 5523.696196709179, 5554.472325129126, 5668.404817494165, 5685.147227915804, 5705.258316418881, 5544.833654990357, 5581.553475721932, 5602.187682786014, 5603.271574695264, 5604.271444712182, 5071.239314102877, 5112.335396398482, 5136.178211486144, 5140.640155189139, 5153.123968925292, 22369.888150559305, 22474.32577022692, 22759.0, 22926.426839328982, 23241.0, 1595.5293188509418, 1602.1268408717276, 1608.3807734022369, 1655.1972293437673, 1655.21377345761, 13525.661858453519, 14210.715785684331, 14284.928575357057, 14384.208868512227, 14912.0, 1680.3782600437794, 1694.805097413801, 1710.144927536232, 1715.6482921001289, 1725.1805392438616, 84790.57604711999, 86754.0, 86799.56600217022, 87004.56497717534, 87851.0, 10294.639687610897, 10508.796481407499, 10523.263371563917, 10619.893801062046, 10733.0, 14448.566543003726, 14461.13233206011, 14494.927525362305, 14539.255289365132, 14548.0, 7787.182345853717, 7828.530288182727, 7960.960195198987, 7984.4810087345295, 8003.719869804645, 7364.484486086029, 7376.852462950818, 7379.631018449056, 7608.391328693802, 7617.428692848059, 6816.0, 6892.862142757217, 6917.412019978257, 6970.198427180838, 7098.148222213367, 1921.68292231783, 1935.090507461491, 1944.8346890514465, 1982.415187519685, 2358.0214211102543, 856.1737922904427, 871.4771137317558, 874.7213508809587, 887.2369762004671, 909.8771665825029, 16933.32266709318, 17080.743788843178, 17715.73426398605, 17837.0, 18054.368097116538, 889.1775108025051, 892.8839250897341, 894.217559635319, 897.6678628907346, 911.7401540560908, 9306.72079837606, 9468.479233642216, 9772.804543909082, 9784.168345690696, 9903.0, 389439.0, 394711.0, 398945.0, 400876.0, 408538.0, 83172.0, 86449.56775216083, 86799.0, 87296.563517182, 89167.10832891718, 1081.8160912644712, 1092.7541303206874, 1117.8546788917552, 1118.9776204475866, 1121.6354684727332, 14854.180168503175, 14916.925415372854, 15127.697446050797, 15189.240537973279, 15317.089752946904, 41975.370369445096, 42483.57516424796, 42689.786551067045, 42788.57211427846, 43683.56316436795, 48922.0, 50073.74963125307, 51377.0, 51738.482615173365, 55066.0, 7297.379722723628, 7483.625818708934, 7527.397808175442, 7528.510646808159, 7593.974813400341, 11644.068474522188, 11747.236429632047, 11840.585579504675, 11944.581939632071, 12190.57332993341, 10157.644482443078, 10205.795884082425, 10271.332363396356, 10363.222758293008, 10728.0, 8644.092370301028, 8714.651413943624, 9102.13529714676, 9155.587998540215, 9336.906630933603, 9484.85772713396, 9579.377340472847, 9881.802363952824, 10440.269181157246, 10646.148308135176, 7370.078740157481, 7410.296021877913, 7476.102867655699, 7585.848283034198, 7766.805829854299, 9528.618855245713, 9850.226959147136, 10032.64885728996, 10264.230182736474, 10379.481025948522], "value": 8714.372770258093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.5560526013267, 1269.7650934577098, 1311.980320295195, 1312.7965165399366, 1317.0714646174447, 9448.622055117796, 9737.074977877099, 9744.951275243622, 9889.752756181098, 10135.49322533874, 9453.858192127123, 9543.713688589336, 9575.904240957605, 9597.568109435075, 9602.327837051409, 2257.1761307122906, 2282.8471621830954, 2292.6446400807818, 2300.194931773874, 2306.273523839985, 2075.543380456305, 2133.797289257518, 2252.560750653623, 2261.276391554695, 2263.7283525976904, 2144.635411979967, 2187.9890600546973, 2223.966640500386, 2238.932832015034, 2243.798058174764, 2154.2352464874903, 2194.133317339642, 2198.0987795004053, 2203.206845535614, 2212.7787221277904, 1790.2838864454193, 1852.7498787663628, 2131.5097527568746, 2209.9116035358566, 2225.788550087755, 9658.30979578571, 9747.853782193273, 9749.805003899883, 9782.804343913082, 9785.11933925943, 5444.265024221719, 5644.3508996465525, 5647.576431767593, 5666.1784041314195, 5675.744591493392, 3300.1914530939835, 3318.0, 3410.334984677989, 3424.2434839953826, 3456.2569047654624, 1012.6759436980169, 1025.9538320775582, 1048.2400259811652, 1054.8206804843119, 1075.4622688655672, 14641.34113964874, 14700.338484768212, 14716.632084197981, 14800.777988330183, 14830.62923426923, 4747.842341804871, 4761.071591039783, 4853.538913803183, 4871.902561948812, 5018.623603229772, 10273.589056437659, 10320.0, 10335.896641033643, 10348.430836303925, 10374.325668831501, 5456.590755693339, 5480.287562616834, 5532.336119665666, 5547.16792481123, 5550.389457159709, 4982.825601104017, 5106.795728170906, 5189.506996835295, 5226.320578324793, 5264.236685680631, 3562.87529936451, 3571.1072231942017, 3628.9274214515563, 3686.760360576554, 3729.086373838427, 1076.1175835814556, 1099.6371197504805, 1106.164845541611, 1115.3029356652091, 1119.0879433261866, 673.1316601584, 693.4071368979551, 697.8115908704622, 705.428602831708, 714.3570786292379, 4916.70499770015, 5025.120603894304, 5035.823746168867, 5040.2691609716385, 5114.897702045938, 551.5863102672995, 567.9602427830013, 575.5539456920836, 577.4831525784399, 583.1398686936734, 3468.687818096333, 3488.2500262443696, 3496.59789124254, 3508.8421021054114, 3584.444411116281, 12440.564580239829, 13182.934085329513, 13190.076694631283, 13205.273709945854, 13223.471061157446, 12734.299613521345, 12893.419796109198, 13023.153495022983, 13081.345932703327, 13116.672083197805, 9311.441313521345, 9357.766055848522, 9408.106229908148, 9453.810923781486, 9475.05249475047, 5440.564754819684, 5539.224508568885, 5601.41185175567, 5620.8875822482505, 5675.68783716883, 11582.942264822772, 11607.535698571963, 11642.883571164519, 11655.358955257543, 11765.823512647146, 11051.889481105407, 11236.719082023015, 12027.338496382434, 12079.335636539723, 12133.0, 7925.0886148093705, 7995.800104997189, 8112.310453611273, 8113.229243221885, 8117.228863257981, 8802.0, 8953.865692014755, 8968.820623587622, 9203.907960920305, 9204.171624553823, 7276.272372762893, 7387.372073373824, 7471.066116735408, 7556.1310449299035, 7622.656980435783, 7571.432142589218, 7714.652840622298, 7758.88361674564, 7853.803654908673, 7902.841943161219, 6601.53789234749, 6762.526623136333, 6778.288279730557, 6797.048413222054, 6804.76183333581, 5189.6886186828915, 5192.896142077213, 5275.788968441219, 5320.467953204648, 5522.0, 5202.635815492879, 5281.762320695655, 5287.947120528899, 5360.410354860885, 5388.326459192601], "value": 4589.342429590444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8829157107083, 408.40373055339205, 410.57710558125143, 412.0378915232929, 418.61696547658886, 5511.641743286694, 5604.271444712187, 5613.522850557702, 5671.1776792365135, 5700.486956173943, 5448.237246785443, 5531.751071201796, 5557.916631250535, 5562.9443705562935, 5579.972100139494, 4302.20409224293, 4305.440292761944, 4319.848805291816, 4326.178026175033, 4330.956690433087, 4153.626173644371, 4270.7864606769535, 4320.783960801963, 4330.350447432878, 4343.283358245885, 4248.596383343577, 4263.12605915788, 4267.935980960288, 4268.103698223377, 4282.421873047146, 4271.67962402821, 4276.957230427687, 4279.807408666617, 4285.571442855705, 4287.063361597316, 3570.428731402963, 3759.1917737686254, 3783.6027217142355, 3784.678302344304, 3785.5646600641003, 5386.272853164812, 5394.838154855361, 5402.459754024605, 5419.647722897999, 5441.374241962146, 4913.329467980903, 4921.950780492185, 4925.926111108336, 4932.040775534686, 4943.961768028718, 5538.643032457034, 5780.161876527922, 5830.0, 5841.153032810261, 5859.736311865976, 4129.752214867118, 4135.8966025849295, 4137.420761093449, 4140.8136633851245, 4154.252234597771, 5729.914051289193, 5962.850928726773, 5999.610025348382, 6151.446369826693, 6229.813105606839, 4189.120284740177, 4211.473565804275, 4231.386448964883, 4232.576742325743, 4238.008136175992, 4267.8079486423185, 4278.358246263086, 4301.505326887448, 4307.763073030951, 4312.870613881589, 4785.976070119627, 4903.950960490421, 4913.108453245526, 4921.360223170965, 4927.841957140069, 5875.823725288248, 5885.997521685295, 5897.64614123154, 5905.143754155623, 5924.229850119457, 1470.4706305729928, 1484.9554513364617, 1488.6576087499936, 1488.7097016081977, 1490.9776353354707, 966.5457235099492, 998.6904059741504, 1007.7050989478631, 1013.4426065663855, 1024.948752562369, 5073.8731531712, 5105.285260063594, 5153.330067091254, 5156.664816786897, 5165.870853228625, 6047.667378294148, 6048.697565121726, 6053.757849685963, 6060.636361818305, 6075.574709770273, 4883.389576302962, 5102.413222479388, 5111.693298402108, 5116.923246151311, 5152.124138896396, 3197.7921435106646, 3228.806271623663, 3236.271838836243, 3241.0276916924827, 3256.3812875553567, 5515.531179849678, 5654.257685022761, 5676.432356764373, 5677.006523858308, 5680.204771331934, 6189.288231853305, 6193.256809182927, 6222.439980401786, 6233.724690487939, 6235.532335074888, 5634.74643641029, 5645.774169033275, 5648.152777083388, 5648.604597678123, 5668.433156684381, 5837.803250333756, 6011.639301641915, 6030.698465076641, 6067.757289708362, 6088.208532890696, 6040.033594624839, 6048.334683184934, 6069.302030266399, 6072.271327440735, 6074.362191969956, 5393.973030134981, 5473.671579705071, 5557.444255574572, 5612.943870561242, 5673.574481913791, 4203.537610862863, 4203.97898010508, 4231.984323762336, 4240.173166232555, 4240.660747140283, 5932.1694962706115, 6095.969520152371, 6098.878022439615, 6100.847478813065, 6105.603135796159, 5854.180414742024, 5872.119182122716, 5916.970415147896, 5919.171316015675, 5938.346781854079, 5869.618474799125, 5874.676892770939, 5876.911846322394, 5885.970570147293, 5888.263967004124, 5637.408072152365, 5795.449432303924, 5819.5635327351465, 5832.270966129234, 5832.825015249549, 5854.590178687451, 5915.858898770792, 5924.437178468039, 5950.137230101697, 5959.080050775003, 5596.888062238651, 5722.370539240764, 5729.367130367992, 5744.396838331915, 5753.71231438418], "value": 4417.727689465962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4721864164591, 689.0559932891939, 691.4572060932169, 711.2496316386214, 720.4524561333388, 12729.681757956045, 12867.742645147091, 13104.737905241902, 13295.7340853183, 13479.595612131652, 12650.304233267167, 12806.423710933008, 12877.098603097787, 12888.484460621565, 13457.125286856348, 824.3940703582847, 849.864021756519, 861.7802460372596, 863.6977058029702, 864.127231496187, 816.8121332093622, 839.5550358310074, 846.9576521173948, 867.6616119713285, 868.7524055644143, 903.4895284164459, 904.416651259937, 906.7733066733317, 913.0413066280412, 913.2602591900549, 895.4000819450983, 896.8206358728248, 903.169084442318, 903.7514683462035, 905.2124651553191, 662.8376047868303, 663.3399767231588, 663.8506336074345, 669.0165456778528, 671.6843083750679, 13012.609621711365, 13062.281574513492, 13121.737565248737, 13169.078164528486, 14625.122492650475, 13330.200187988752, 13824.930875345659, 14051.929740351336, 14110.0, 14276.930459951056, 10038.297319187659, 10313.690589282334, 10515.263931524796, 10684.145268378512, 10695.946520267427, 2708.444768822387, 2742.780577553791, 2742.9862850685818, 2758.8620568971473, 2770.8060435769503, 61772.691136544476, 62076.0, 62817.68591157015, 62929.37070629281, 63107.368926310606, 10333.948330258301, 10445.164386849034, 10473.162147028219, 10567.63013294531, 10699.465026748632, 21160.682589761167, 21205.78794212069, 21432.464188395414, 21458.0, 21524.56950860974, 6281.905771413432, 6473.870522589522, 6570.671466426755, 6579.605223686594, 6770.119884415093, 3319.7012268895915, 3398.167448975017, 3404.9489257661153, 3407.4548072308808, 3466.739994500372, 3707.4994875691978, 3750.643688849555, 3756.962430375716, 3776.169242766587, 3829.9808500957315, 662.867426514699, 665.1087542692718, 666.2804171494774, 679.7518905599519, 684.2234064337014, 494.26107968587195, 513.7354262554712, 517.4747631154381, 527.8442859356499, 528.4983323601292, 8117.269445749911, 8173.7139200128895, 8201.630926608197, 8367.623456944451, 8494.575271236414, 502.7084291111147, 507.5482820289945, 519.7323378460096, 524.8320537428062, 526.2553486816189, 3519.4544845548467, 3524.646115365627, 3555.235624340779, 3564.590072141737, 3637.1089083174793, 60131.699341503016, 61794.0, 61819.0, 64087.67956160189, 64709.67645161744, 55675.44324556783, 56090.719546402004, 56343.71828140833, 57285.0, 57513.42486575081, 48909.266361004615, 49197.754011229714, 49351.25973110406, 50267.24599131016, 50310.496895030585, 7139.714411423693, 7247.927520724726, 7281.0, 7355.080614923135, 7370.787410973569, 25464.595159844488, 25532.872335638946, 25858.87070564635, 26408.603870941566, 27071.323216919736, 31990.200244994063, 32001.359972800878, 32065.519017214294, 32846.0, 32919.17702057372, 9864.901350986398, 10057.346272492558, 10177.49112544355, 10237.181025517792, 10636.361818290927, 10637.627683031056, 10670.679879603624, 10785.946070269598, 10997.12023038139, 11065.059469944823, 9589.904100958902, 10370.27408081427, 10378.532966016699, 10423.478826058516, 10794.298370605886, 9767.951160244153, 10021.448820314952, 10148.695539133838, 10538.998795114452, 10558.947205263925, 9309.44143351401, 9791.853122203314, 9847.704568862946, 10160.593576256866, 10263.332883362558, 7231.385332246818, 7282.235365286569, 7410.629468526445, 7589.5066820658685, 7702.040328365275, 7187.281271872771, 7524.435667325082, 7942.801429964066, 8164.591770411337, 8330.791730206793], "value": 6014.401987995, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 113.0, 113.0, 112.0, 112.0, 111.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 125.0, 186.0, 125.0, 126.0, 125.0, 126.0, 156.0, 127.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 164.0, 171.0, 167.0, 170.0, 163.0, 165.0, 163.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 111.0, 76.0, 78.0, 76.0, 75.0, 91.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 104.0, 88.0, 87.0, 86.0, 108.0, 84.0, 85.0, 107.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 113.0, 115.0, 113.0, 116.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 151.0, 151.0, 150.0, 152.0, 151.0, 152.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 77.0, 69.0, 72.0, 71.0, 70.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 92.0, 83.0, 86.0, 83.0, 82.0, 90.0, 82.0, 91.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 152.0, 133.0, 137.0, 139.0, 145.0, 138.0, 188.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 212.0, 193.0, 187.0, 194.0, 193.0, 205.0, 193.0, 197.0, 197.0], "value": 196.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 71.0, 77.0, 70.0, 73.0, 70.0, 70.0, 70.0], "value": 72.3, "unit": "score"}]}]} 15:11:27 INFO - Return code: 0 15:11:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:11:27 ERROR - # TBPL SUCCESS # 15:11:27 INFO - Running post-action listener: _resource_record_post_action 15:11:27 INFO - [mozharness: 2017-03-27 22:11:27.814851Z] Finished run-tests step (success) 15:11:27 INFO - Running post-run listener: _resource_record_post_run 15:11:27 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374095872; Read time: 12; Write time: 218188 15:11:27 INFO - TinderboxPrint: CPU usage
13.3% 15:11:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:11:27 INFO - TinderboxPrint: I/O write bytes / time
374,095,872 / 218,188 15:11:27 INFO - TinderboxPrint: CPU idle
8,322.5 (86.7%) 15:11:27 INFO - TinderboxPrint: CPU user
1,221.1 (12.7%) 15:11:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:11:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113680384; Read time: 0; Write time: 81440 15:11:27 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 260046848; Read time: 0; Write time: 136728 15:11:28 INFO - Running post-run listener: _upload_blobber_files 15:11:28 INFO - Blob upload gear active. 15:11:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:28 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 15:11:28 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'] 15:11:28 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 15:11:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:29 INFO - (blobuploader) - INFO - Done attempting. 15:11:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:11:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:30 INFO - (blobuploader) - INFO - Done attempting. 15:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:31 INFO - (blobuploader) - INFO - Done attempting. 15:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:35 INFO - (blobuploader) - INFO - Done attempting. 15:11:35 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:35 INFO - Return code: 0 15:11:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84c75e2f39747707a4e89f245fb4243e197cefd90d847598a5fd028f27e22c7cef458175492a7a2c083c8819a200b4c534076a26fa88b876fe057329e92f191d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4291e5ae63830b236c013473898fde188d9b6f4140591d738484c902f341d983da1c21c149dcd0567a35af28fbc4067b27144607ffffb5b4852b4dfd281d1cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6ff4a7938fc4a89278052b575b6b87670a7f79f150a278969ab6fcb6dbffcdd2979aff259666f1c79d87b08878b48b822cc7788cad7c89381067dfff811e13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/921deefcca37b9986eda0cf761d59f9ffc3206040f95f40d8ca6edefee35ed0161541bfcd5debb5568645f7d1753263a5ffe885f63c54f9b58b1b575a67ecf00"} 15:11:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:35 INFO - Contents: 15:11:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84c75e2f39747707a4e89f245fb4243e197cefd90d847598a5fd028f27e22c7cef458175492a7a2c083c8819a200b4c534076a26fa88b876fe057329e92f191d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4291e5ae63830b236c013473898fde188d9b6f4140591d738484c902f341d983da1c21c149dcd0567a35af28fbc4067b27144607ffffb5b4852b4dfd281d1cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6ff4a7938fc4a89278052b575b6b87670a7f79f150a278969ab6fcb6dbffcdd2979aff259666f1c79d87b08878b48b822cc7788cad7c89381067dfff811e13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/921deefcca37b9986eda0cf761d59f9ffc3206040f95f40d8ca6edefee35ed0161541bfcd5debb5568645f7d1753263a5ffe885f63c54f9b58b1b575a67ecf00"} 15:11:35 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:35 INFO - Copying logs to upload dir... 15:11:35 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.277362 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-27 15:11:35.326038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:11:35.329545) ========= 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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84c75e2f39747707a4e89f245fb4243e197cefd90d847598a5fd028f27e22c7cef458175492a7a2c083c8819a200b4c534076a26fa88b876fe057329e92f191d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4291e5ae63830b236c013473898fde188d9b6f4140591d738484c902f341d983da1c21c149dcd0567a35af28fbc4067b27144607ffffb5b4852b4dfd281d1cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6ff4a7938fc4a89278052b575b6b87670a7f79f150a278969ab6fcb6dbffcdd2979aff259666f1c79d87b08878b48b822cc7788cad7c89381067dfff811e13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/921deefcca37b9986eda0cf761d59f9ffc3206040f95f40d8ca6edefee35ed0161541bfcd5debb5568645f7d1753263a5ffe885f63c54f9b58b1b575a67ecf00"} build_url:https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/Ghl18wyVRBmTNDHD1aOwbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/84c75e2f39747707a4e89f245fb4243e197cefd90d847598a5fd028f27e22c7cef458175492a7a2c083c8819a200b4c534076a26fa88b876fe057329e92f191d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4291e5ae63830b236c013473898fde188d9b6f4140591d738484c902f341d983da1c21c149dcd0567a35af28fbc4067b27144607ffffb5b4852b4dfd281d1cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6ff4a7938fc4a89278052b575b6b87670a7f79f150a278969ab6fcb6dbffcdd2979aff259666f1c79d87b08878b48b822cc7788cad7c89381067dfff811e13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/921deefcca37b9986eda0cf761d59f9ffc3206040f95f40d8ca6edefee35ed0161541bfcd5debb5568645f7d1753263a5ffe885f63c54f9b58b1b575a67ecf00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 15:11:35.357248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:11:35.357788) ========= 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=3297cc2eebb5444a7688c33f000001b5-1490651430.384039-2023724324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 15:11:35.441000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 15:11:35.441333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 15:11:35.441630) ========= ========= Total master_lag: 0.17 =========