builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-083 starttime: 1490365128.95 results: success (0) revision: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:48.946616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:48.947101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:48.947386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:48.962516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:48.962873) ========= 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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-24 07:18:49-- 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% 23.3M=0s 2017-03-24 07:18:49 (23.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.119551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.119873) ========= 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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.169828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.170180) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd --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 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd --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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-24 07:18:49,710 truncating revision to first 12 chars 2017-03-24 07:18:49,710 Setting DEBUG logging. 2017-03-24 07:18:49,710 attempt 1/10 2017-03-24 07:18:49,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c987b7ed54a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 07:18:50,057 unpacking tar archive at: mozilla-central-4c987b7ed54a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.906924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.907462) ========= script_repo_revision: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.907896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.908173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:49.918208) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-24 07:18:49.918721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:50 INFO - MultiFileLogger online at 20170324 07:18:50 in /builds/slave/test 07:18:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:18:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:50 INFO - {'append_to_log': False, 07:18:50 INFO - 'base_work_dir': '/builds/slave/test', 07:18:50 INFO - 'blob_upload_branch': 'Firefox', 07:18:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:50 INFO - 'branch': 'Firefox', 07:18:50 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:50 INFO - 'config_files': ('talos/linux_config.py',), 07:18:50 INFO - 'default_actions': ('clobber', 07:18:50 INFO - 'read-buildbot-config', 07:18:50 INFO - 'download-and-extract', 07:18:50 INFO - 'populate-webroot', 07:18:50 INFO - 'create-virtualenv', 07:18:50 INFO - 'install', 07:18:50 INFO - 'run-tests'), 07:18:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:50 INFO - 'download_minidump_stackwalk': True, 07:18:50 INFO - 'download_symbols': 'ondemand', 07:18:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:50 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:50 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:50 INFO - 'gecko_profile': False, 07:18:50 INFO - 'gecko_profile_interval': 0, 07:18:50 INFO - 'installer_path': 'installer.exe', 07:18:50 INFO - 'log_level': 'info', 07:18:50 INFO - 'log_name': 'talos', 07:18:50 INFO - 'log_to_console': True, 07:18:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:50 INFO - 'opt_config_files': (), 07:18:50 INFO - 'pip_index': False, 07:18:50 INFO - 'suite': 'dromaeojs', 07:18:50 INFO - 'system_bits': '32', 07:18:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:50 INFO - 'title': 'talos-linux64-ix-083', 07:18:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:50 INFO - 'use_talos_json': True, 07:18:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:50 INFO - 'work_dir': 'build'} 07:18:50 INFO - [mozharness: 2017-03-24 14:18:50.557651Z] Running clobber step. 07:18:50 INFO - Running pre-action listener: _resource_record_pre_action 07:18:50 INFO - Running main action method: clobber 07:18:50 INFO - rmtree: /builds/slave/test/build 07:18:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:51 INFO - Running post-action listener: _resource_record_post_action 07:18:51 INFO - [mozharness: 2017-03-24 14:18:51.501606Z] Finished clobber step (success) 07:18:51 INFO - [mozharness: 2017-03-24 14:18:51.501705Z] Running read-buildbot-config step. 07:18:51 INFO - Running pre-action listener: _resource_record_pre_action 07:18:51 INFO - Running main action method: read_buildbot_config 07:18:51 INFO - Using buildbot properties: 07:18:51 INFO - { 07:18:51 INFO - "project": "", 07:18:51 INFO - "product": "firefox", 07:18:51 INFO - "who": "cbook@mozilla.com", 07:18:51 INFO - "installer_path": "public/build/target.tar.bz2", 07:18:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:18:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:18:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:18:51 INFO - "stage_platform": "linux64-pgo", 07:18:51 INFO - "basedir": "/builds/slave/test", 07:18:51 INFO - "buildnumber": 94, 07:18:51 INFO - "platform": "ubuntu64_hw", 07:18:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:18:51 INFO - "slavebuilddir": "test", 07:18:51 INFO - "taskId": "WJ4czwHrToGD-FxwqPJGow", 07:18:51 INFO - "branch": "mozilla-central", 07:18:51 INFO - "script_repo_revision": "production", 07:18:51 INFO - "revision": "4c987b7ed54a630a7de76adcc2eb00dab49d5dfd", 07:18:51 INFO - "slavename": "talos-linux64-ix-083", 07:18:51 INFO - "repo_path": "mozilla-central" 07:18:51 INFO - } 07:18:51 INFO - Finding installer, test and symbols from parent task. 07:18:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ4czwHrToGD-FxwqPJGow'}, attempt #1 07:18:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ4czwHrToGD-FxwqPJGow'}, attempt #1 07:18:52 INFO - Task dependencies: cRpriiMFRlWsc_RYTC3c5Q 07:18:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q'}, attempt #1 07:18:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 07:18:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/test_packages.json 07:18:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.crashreporter-symbols.zip 07:18:52 INFO - Running post-action listener: _resource_record_post_action 07:18:52 INFO - [mozharness: 2017-03-24 14:18:52.891348Z] Finished read-buildbot-config step (success) 07:18:52 INFO - [mozharness: 2017-03-24 14:18:52.891569Z] Running download-and-extract step. 07:18:52 INFO - Running pre-action listener: _resource_record_pre_action 07:18:52 INFO - Running main action method: download_and_extract 07:18:52 INFO - mkdir: /builds/slave/test/build/tests 07:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:52 INFO - trying https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.test_packages.json 07:18:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:18:53 INFO - Downloaded 986 bytes. 07:18:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:18:53 INFO - Using the following test package requirements: 07:18:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:18:53 INFO - u'common': [u'target.common.tests.zip'], 07:18:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:18:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:18:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:18:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:18:53 INFO - u'mozbase': [u'target.common.tests.zip'], 07:18:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:18:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:18:53 INFO - u'web-platform': [u'target.common.tests.zip', 07:18:53 INFO - u'target.web-platform.tests.zip'], 07:18:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:18:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:18:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip 07:18:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:18:53 INFO - Fetch https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip into memory 07:18:54 INFO - Expected file size: 60251023 07:18:54 INFO - Obtained file size: 60251023 07:19:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:19:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip 07:19:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:19:04 INFO - Fetch https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.common.tests.zip into memory 07:19:05 INFO - Expected file size: 60251023 07:19:05 INFO - Obtained file size: 60251023 07:19:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.talos.tests.zip 07:19:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:19:16 INFO - Fetch https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.talos.tests.zip into memory 07:19:17 INFO - Expected file size: 14404171 07:19:17 INFO - Obtained file size: 14404171 07:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:17 INFO - trying https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 07:19:17 INFO - Downloading https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:19:18 INFO - Downloaded 68065563 bytes. 07:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 07:19:18 INFO - mkdir: /builds/slave/test/properties 07:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:19:18 INFO - Contents: 07:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 07:19:18 INFO - Running post-action listener: _resource_record_post_action 07:19:18 INFO - Running post-action listener: set_extra_try_arguments 07:19:18 INFO - [mozharness: 2017-03-24 14:19:18.758056Z] Finished download-and-extract step (success) 07:19:18 INFO - [mozharness: 2017-03-24 14:19:18.758152Z] Running populate-webroot step. 07:19:18 INFO - Running pre-action listener: _resource_record_pre_action 07:19:18 INFO - Running main action method: populate_webroot 07:19:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:19:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:19:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:19:18 INFO - '--tppagecycles', 07:19:18 INFO - '7'], 07:19:18 INFO - 'tests': ['tsvgm']}}, 07:19:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:19:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:19:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:19:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:19:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['damp', 'tps']}, 07:19:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'tests': ['damp', 'tps']}, 07:19:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['dromaeo_dom']}, 07:19:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:19:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['basic_compositor_video']}, 07:19:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:19:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['a11yr', 07:19:18 INFO - 'ts_paint', 07:19:18 INFO - 'tpaint', 07:19:18 INFO - 'sessionrestore', 07:19:18 INFO - 'sessionrestore_no_auto_restore', 07:19:18 INFO - 'tabpaint']}, 07:19:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['tsvgx', 07:19:18 INFO - 'tsvgr_opacity', 07:19:18 INFO - 'tart', 07:19:18 INFO - 'tscrollx', 07:19:18 INFO - 'cart', 07:19:18 INFO - 'tsvg_static']}, 07:19:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:19:18 INFO - 'tsvgr_opacity', 07:19:18 INFO - 'tart', 07:19:18 INFO - 'tscrollx', 07:19:18 INFO - 'cart', 07:19:18 INFO - 'tsvg_static']}, 07:19:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'talos_options': ['--disable-e10s'], 07:19:18 INFO - 'tests': ['tp5o']}, 07:19:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:19:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'talos_options': ['--disable-e10s', 07:19:18 INFO - '--xperf_path', 07:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:18 INFO - 'tests': ['tp5n']}, 07:19:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:19:18 INFO - 'talos_options': ['--xperf_path', 07:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:18 INFO - 'tests': ['tp5n']}}, 07:19:18 INFO - 'talos.zip': {'path': '', 07:19:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:19:18 INFO - Running post-action listener: _resource_record_post_action 07:19:18 INFO - [mozharness: 2017-03-24 14:19:18.771253Z] Finished populate-webroot step (success) 07:19:18 INFO - [mozharness: 2017-03-24 14:19:18.771344Z] Running create-virtualenv step. 07:19:18 INFO - Running pre-action listener: _resource_record_pre_action 07:19:18 INFO - Running main action method: create_virtualenv 07:19:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:19:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:19:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:19:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:19:18 INFO - Using real prefix '/usr' 07:19:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:19:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:19:21 INFO - Installing pip.................done. 07:19:21 INFO - Return code: 0 07:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:19:21 INFO - Reading from file tmpfile_stdout 07:19:21 INFO - Output received: 07:19:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:19:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:19:21 INFO - Using env: {'DISPLAY': ':0', 07:19:21 INFO - 'HOME': '/home/cltbld', 07:19:21 INFO - 'LANG': 'en_US.UTF-8', 07:19:21 INFO - 'LANGUAGE': 'en_US:en', 07:19:21 INFO - 'LOGNAME': 'cltbld', 07:19:21 INFO - 'MAIL': '/var/mail/cltbld', 07:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:21 INFO - 'MOZ_NO_REMOTE': '1', 07:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:21 INFO - 'NO_EM_RESTART': '1', 07:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:21 INFO - 'PWD': '/builds/slave/test', 07:19:21 INFO - 'SHELL': '/bin/bash', 07:19:21 INFO - 'SHLVL': '1', 07:19:21 INFO - 'TERM': 'linux', 07:19:21 INFO - 'TMOUT': '86400', 07:19:21 INFO - 'USER': 'cltbld', 07:19:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:21 INFO - '_': '/tools/buildbot/bin/python'} 07:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:19:21 INFO - Cleaning up... 07:19:21 INFO - Return code: 0 07:19:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:19:21 INFO - Using env: {'DISPLAY': ':0', 07:19:21 INFO - 'HOME': '/home/cltbld', 07:19:21 INFO - 'LANG': 'en_US.UTF-8', 07:19:21 INFO - 'LANGUAGE': 'en_US:en', 07:19:21 INFO - 'LOGNAME': 'cltbld', 07:19:21 INFO - 'MAIL': '/var/mail/cltbld', 07:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:21 INFO - 'MOZ_NO_REMOTE': '1', 07:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:21 INFO - 'NO_EM_RESTART': '1', 07:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:21 INFO - 'PWD': '/builds/slave/test', 07:19:21 INFO - 'SHELL': '/bin/bash', 07:19:21 INFO - 'SHLVL': '1', 07:19:21 INFO - 'TERM': 'linux', 07:19:21 INFO - 'TMOUT': '86400', 07:19:21 INFO - 'USER': 'cltbld', 07:19:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:21 INFO - '_': '/tools/buildbot/bin/python'} 07:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:21 INFO - Downloading/unpacking psutil>=3.1.1 07:19: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 07:19: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 07:19: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 07:19: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 07:19: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 07:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:24 INFO - Installing collected packages: psutil 07:19:24 INFO - Running setup.py install for psutil 07:19:24 INFO - building 'psutil._psutil_linux' extension 07:19:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:19:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:19:24 INFO - building 'psutil._psutil_posix' extension 07:19:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:19:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:19:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:24 INFO - Successfully installed psutil 07:19:24 INFO - Cleaning up... 07:19:24 INFO - Return code: 0 07:19:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:19:24 INFO - Using env: {'DISPLAY': ':0', 07:19:24 INFO - 'HOME': '/home/cltbld', 07:19:24 INFO - 'LANG': 'en_US.UTF-8', 07:19:24 INFO - 'LANGUAGE': 'en_US:en', 07:19:24 INFO - 'LOGNAME': 'cltbld', 07:19:24 INFO - 'MAIL': '/var/mail/cltbld', 07:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:24 INFO - 'MOZ_NO_REMOTE': '1', 07:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:24 INFO - 'NO_EM_RESTART': '1', 07:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:24 INFO - 'PWD': '/builds/slave/test', 07:19:24 INFO - 'SHELL': '/bin/bash', 07:19:24 INFO - 'SHLVL': '1', 07:19:24 INFO - 'TERM': 'linux', 07:19:24 INFO - 'TMOUT': '86400', 07:19:24 INFO - 'USER': 'cltbld', 07:19:24 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:24 INFO - '_': '/tools/buildbot/bin/python'} 07:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:19:26 INFO - Installing collected packages: mozsystemmonitor 07:19:26 INFO - Running setup.py install for mozsystemmonitor 07:19:27 INFO - Successfully installed mozsystemmonitor 07:19:27 INFO - Cleaning up... 07:19:27 INFO - Return code: 0 07:19:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:19:27 INFO - Using env: {'DISPLAY': ':0', 07:19:27 INFO - 'HOME': '/home/cltbld', 07:19:27 INFO - 'LANG': 'en_US.UTF-8', 07:19:27 INFO - 'LANGUAGE': 'en_US:en', 07:19:27 INFO - 'LOGNAME': 'cltbld', 07:19:27 INFO - 'MAIL': '/var/mail/cltbld', 07:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:27 INFO - 'MOZ_NO_REMOTE': '1', 07:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:27 INFO - 'NO_EM_RESTART': '1', 07:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:27 INFO - 'PWD': '/builds/slave/test', 07:19:27 INFO - 'SHELL': '/bin/bash', 07:19:27 INFO - 'SHLVL': '1', 07:19:27 INFO - 'TERM': 'linux', 07:19:27 INFO - 'TMOUT': '86400', 07:19:27 INFO - 'USER': 'cltbld', 07:19:27 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:27 INFO - '_': '/tools/buildbot/bin/python'} 07:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:27 INFO - Downloading/unpacking jsonschema==2.5.1 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:29 INFO - warning: no files found matching '*.txt' 07:19:29 INFO - no previously-included directories found matching 'build' 07:19:29 INFO - no previously-included directories found matching 'dist' 07:19:29 INFO - no previously-included directories found matching '.git*' 07:19:29 INFO - Installing collected packages: jsonschema, functools32 07:19:29 INFO - Running setup.py install for functools32 07:19:29 INFO - warning: no files found matching '*.txt' 07:19:29 INFO - no previously-included directories found matching 'build' 07:19:29 INFO - no previously-included directories found matching 'dist' 07:19:29 INFO - no previously-included directories found matching '.git*' 07:19:29 INFO - Successfully installed jsonschema functools32 07:19:29 INFO - Cleaning up... 07:19:29 INFO - Return code: 0 07:19:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:29 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:19:29 INFO - Using env: {'DISPLAY': ':0', 07:19:29 INFO - 'HOME': '/home/cltbld', 07:19:29 INFO - 'LANG': 'en_US.UTF-8', 07:19:29 INFO - 'LANGUAGE': 'en_US:en', 07:19:29 INFO - 'LOGNAME': 'cltbld', 07:19:29 INFO - 'MAIL': '/var/mail/cltbld', 07:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:29 INFO - 'MOZ_NO_REMOTE': '1', 07:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:29 INFO - 'NO_EM_RESTART': '1', 07:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:29 INFO - 'PWD': '/builds/slave/test', 07:19:29 INFO - 'SHELL': '/bin/bash', 07:19:29 INFO - 'SHLVL': '1', 07:19:29 INFO - 'TERM': 'linux', 07:19:29 INFO - 'TMOUT': '86400', 07:19:29 INFO - 'USER': 'cltbld', 07:19:29 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:29 INFO - '_': '/tools/buildbot/bin/python'} 07:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:19:30 INFO - Cleaning up... 07:19:30 INFO - Return code: 0 07:19:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:19:30 INFO - Using env: {'DISPLAY': ':0', 07:19:30 INFO - 'HOME': '/home/cltbld', 07:19:30 INFO - 'LANG': 'en_US.UTF-8', 07:19:30 INFO - 'LANGUAGE': 'en_US:en', 07:19:30 INFO - 'LOGNAME': 'cltbld', 07:19:30 INFO - 'MAIL': '/var/mail/cltbld', 07:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:30 INFO - 'MOZ_NO_REMOTE': '1', 07:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:30 INFO - 'NO_EM_RESTART': '1', 07:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:30 INFO - 'PWD': '/builds/slave/test', 07:19:30 INFO - 'SHELL': '/bin/bash', 07:19:30 INFO - 'SHLVL': '1', 07:19:30 INFO - 'TERM': 'linux', 07:19:30 INFO - 'TMOUT': '86400', 07:19:30 INFO - 'USER': 'cltbld', 07:19:30 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:30 INFO - '_': '/tools/buildbot/bin/python'} 07:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:32 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:33 INFO - Downloading docopt-0.6.1.tar.gz 07:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:33 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:33 INFO - Running setup.py install for blobuploader 07:19:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:33 INFO - Running setup.py install for requests 07:19:33 INFO - Running setup.py install for docopt 07:19:33 INFO - Successfully installed blobuploader requests docopt 07:19:33 INFO - Cleaning up... 07:19:33 INFO - Return code: 0 07:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:33 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:33 INFO - Using env: {'DISPLAY': ':0', 07:19:33 INFO - 'HOME': '/home/cltbld', 07:19:33 INFO - 'LANG': 'en_US.UTF-8', 07:19:33 INFO - 'LANGUAGE': 'en_US:en', 07:19:33 INFO - 'LOGNAME': 'cltbld', 07:19:33 INFO - 'MAIL': '/var/mail/cltbld', 07:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:33 INFO - 'MOZ_NO_REMOTE': '1', 07:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:33 INFO - 'NO_EM_RESTART': '1', 07:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:33 INFO - 'PWD': '/builds/slave/test', 07:19:33 INFO - 'SHELL': '/bin/bash', 07:19:33 INFO - 'SHLVL': '1', 07:19:33 INFO - 'TERM': 'linux', 07:19:33 INFO - 'TMOUT': '86400', 07:19:33 INFO - 'USER': 'cltbld', 07:19:33 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:33 INFO - '_': '/tools/buildbot/bin/python'} 07:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:33 INFO - Running setup.py (path:/tmp/pip-VQoZYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:34 INFO - Running setup.py (path:/tmp/pip-RFfemu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:34 INFO - Running setup.py (path:/tmp/pip-Aq4UEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:34 INFO - Running setup.py (path:/tmp/pip-w8AJDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:34 INFO - Running setup.py (path:/tmp/pip-s5gJpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:34 INFO - Running setup.py (path:/tmp/pip-4yJpGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:34 INFO - Running setup.py (path:/tmp/pip-uUW3wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:34 INFO - Running setup.py (path:/tmp/pip-rpW2Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:34 INFO - Running setup.py (path:/tmp/pip-T_fGpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:34 INFO - Running setup.py (path:/tmp/pip-Zhq5Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:34 INFO - Running setup.py (path:/tmp/pip-DFFQCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:34 INFO - Running setup.py (path:/tmp/pip-LV5nUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:34 INFO - Running setup.py (path:/tmp/pip-lnF7jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:34 INFO - Running setup.py (path:/tmp/pip-dOESgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:34 INFO - Running setup.py (path:/tmp/pip-UJvu1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:35 INFO - Running setup.py (path:/tmp/pip-0c5wYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:35 INFO - Running setup.py (path:/tmp/pip-4QLSJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:35 INFO - Running setup.py install for manifestparser 07:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Running setup.py install for mozcrash 07:19:35 INFO - Running setup.py install for mozdebug 07:19:35 INFO - Running setup.py install for mozdevice 07:19:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Running setup.py install for mozfile 07:19:35 INFO - Running setup.py install for mozhttpd 07:19:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Running setup.py install for mozinfo 07:19:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Running setup.py install for mozInstall 07:19:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:35 INFO - Running setup.py install for mozleak 07:19:36 INFO - Running setup.py install for mozlog 07:19:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Running setup.py install for moznetwork 07:19:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Running setup.py install for mozprocess 07:19:36 INFO - Running setup.py install for mozprofile 07:19:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Running setup.py install for mozrunner 07:19:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Running setup.py install for mozscreenshot 07:19:36 INFO - Running setup.py install for moztest 07:19:36 INFO - Running setup.py install for mozversion 07:19:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:36 INFO - Cleaning up... 07:19:36 INFO - Return code: 0 07:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:36 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:36 INFO - Using env: {'DISPLAY': ':0', 07:19:36 INFO - 'HOME': '/home/cltbld', 07:19:36 INFO - 'LANG': 'en_US.UTF-8', 07:19:36 INFO - 'LANGUAGE': 'en_US:en', 07:19:36 INFO - 'LOGNAME': 'cltbld', 07:19:36 INFO - 'MAIL': '/var/mail/cltbld', 07:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:36 INFO - 'MOZ_NO_REMOTE': '1', 07:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:36 INFO - 'NO_EM_RESTART': '1', 07:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:36 INFO - 'PWD': '/builds/slave/test', 07:19:36 INFO - 'SHELL': '/bin/bash', 07:19:36 INFO - 'SHLVL': '1', 07:19:36 INFO - 'TERM': 'linux', 07:19:36 INFO - 'TMOUT': '86400', 07:19:36 INFO - 'USER': 'cltbld', 07:19:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:36 INFO - '_': '/tools/buildbot/bin/python'} 07:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:37 INFO - Running setup.py (path:/tmp/pip-4D57kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:37 INFO - Running setup.py (path:/tmp/pip-z9U6Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:37 INFO - Running setup.py (path:/tmp/pip-tcoP5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:37 INFO - Running setup.py (path:/tmp/pip-y80LfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:37 INFO - Running setup.py (path:/tmp/pip-2aLxKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:37 INFO - Running setup.py (path:/tmp/pip-vJ1GJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:37 INFO - Running setup.py (path:/tmp/pip-EicIbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:37 INFO - Running setup.py (path:/tmp/pip-2KDHfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:37 INFO - Running setup.py (path:/tmp/pip-_NMYT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:37 INFO - Running setup.py (path:/tmp/pip-oeFgPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:37 INFO - Running setup.py (path:/tmp/pip-4rruIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:37 INFO - Running setup.py (path:/tmp/pip-0tcWxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:38 INFO - Running setup.py (path:/tmp/pip-UVUYiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:38 INFO - Running setup.py (path:/tmp/pip-I9PAeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:38 INFO - Running setup.py (path:/tmp/pip-d4HU7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:38 INFO - Running setup.py (path:/tmp/pip-qa4R24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:38 INFO - Running setup.py (path:/tmp/pip-Bon8Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:40 INFO - Downloading blessings-1.6.tar.gz 07:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:40 INFO - Installing collected packages: blessings 07:19:40 INFO - Running setup.py install for blessings 07:19:40 INFO - Successfully installed blessings 07:19:40 INFO - Cleaning up... 07:19:40 INFO - Return code: 0 07:19:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:40 INFO - Reading from file tmpfile_stdout 07:19:40 INFO - Current package versions: 07:19:40 INFO - argparse == 1.2.1 07:19:40 INFO - blessings == 1.6 07:19:40 INFO - blobuploader == 1.2.4 07:19:40 INFO - docopt == 0.6.1 07:19:40 INFO - functools32 == 3.2.3-2 07:19:40 INFO - jsonschema == 2.5.1 07:19:40 INFO - manifestparser == 1.1 07:19:40 INFO - mozInstall == 1.12 07:19:40 INFO - mozcrash == 1.0 07:19:40 INFO - mozdebug == 0.1 07:19:40 INFO - mozdevice == 0.49 07:19:40 INFO - mozfile == 1.2 07:19:40 INFO - mozhttpd == 0.7 07:19:40 INFO - mozinfo == 0.9 07:19:40 INFO - mozleak == 0.1 07:19:40 INFO - mozlog == 3.4 07:19:40 INFO - moznetwork == 0.27 07:19:40 INFO - mozprocess == 0.25 07:19:40 INFO - mozprofile == 0.28 07:19:40 INFO - mozrunner == 6.13 07:19:40 INFO - mozscreenshot == 0.1 07:19:40 INFO - mozsystemmonitor == 0.3 07:19:40 INFO - moztest == 0.8 07:19:40 INFO - mozversion == 1.4 07:19:40 INFO - psutil == 3.1.1 07:19:40 INFO - requests == 1.2.3 07:19:40 INFO - wsgiref == 0.1.2 07:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:40 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:40 INFO - Using env: {'DISPLAY': ':0', 07:19:40 INFO - 'HOME': '/home/cltbld', 07:19:40 INFO - 'LANG': 'en_US.UTF-8', 07:19:40 INFO - 'LANGUAGE': 'en_US:en', 07:19:40 INFO - 'LOGNAME': 'cltbld', 07:19:40 INFO - 'MAIL': '/var/mail/cltbld', 07:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:40 INFO - 'MOZ_NO_REMOTE': '1', 07:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:40 INFO - 'NO_EM_RESTART': '1', 07:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:40 INFO - 'PWD': '/builds/slave/test', 07:19:40 INFO - 'SHELL': '/bin/bash', 07:19:40 INFO - 'SHLVL': '1', 07:19:40 INFO - 'TERM': 'linux', 07:19:40 INFO - 'TMOUT': '86400', 07:19:40 INFO - 'USER': 'cltbld', 07:19:40 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:40 INFO - '_': '/tools/buildbot/bin/python'} 07:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:41 INFO - Cleaning up... 07:19:41 INFO - Return code: 0 07:19:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:41 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 0x25841f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2822310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, '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-1490365128.822787-1677145202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:19:41 INFO - Using env: {'DISPLAY': ':0', 07:19:41 INFO - 'HOME': '/home/cltbld', 07:19:41 INFO - 'LANG': 'en_US.UTF-8', 07:19:41 INFO - 'LANGUAGE': 'en_US:en', 07:19:41 INFO - 'LOGNAME': 'cltbld', 07:19:41 INFO - 'MAIL': '/var/mail/cltbld', 07:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:41 INFO - 'MOZ_NO_REMOTE': '1', 07:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:41 INFO - 'NO_EM_RESTART': '1', 07:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:41 INFO - 'PWD': '/builds/slave/test', 07:19:41 INFO - 'SHELL': '/bin/bash', 07:19:41 INFO - 'SHLVL': '1', 07:19:41 INFO - 'TERM': 'linux', 07:19:41 INFO - 'TMOUT': '86400', 07:19:41 INFO - 'USER': 'cltbld', 07:19:41 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:41 INFO - '_': '/tools/buildbot/bin/python'} 07:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:41 INFO - Cleaning up... 07:19:41 INFO - Return code: 0 07:19:41 INFO - Running post-action listener: _resource_record_post_action 07:19:41 INFO - Running post-action listener: _start_resource_monitoring 07:19:41 INFO - Starting resource monitoring. 07:19:41 INFO - [mozharness: 2017-03-24 14:19:41.401021Z] Finished create-virtualenv step (success) 07:19:41 INFO - [mozharness: 2017-03-24 14:19:41.401569Z] Running install step. 07:19:41 INFO - Running pre-action listener: _resource_record_pre_action 07:19:41 INFO - Running main action method: install 07:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:41 INFO - Reading from file tmpfile_stdout 07:19:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:41 INFO - Reading from file tmpfile_stdout 07:19:41 INFO - Output received: 07:19:41 INFO - Usage: mozinstall [options] installer 07:19:41 INFO - Options: 07:19:41 INFO - -h, --help show this help message and exit 07:19:41 INFO - -d DEST, --destination=DEST 07:19:41 INFO - Directory to install application into. [default: 07:19:41 INFO - "/builds/slave/test"] 07:19:41 INFO - --app=APP Application being installed. [default: firefox] 07:19:41 INFO - mkdir: /builds/slave/test/build/application 07:19:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:19:58 INFO - Reading from file tmpfile_stdout 07:19:58 INFO - Output received: 07:19:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:58 INFO - Running post-action listener: _resource_record_post_action 07:19:58 INFO - [mozharness: 2017-03-24 14:19:58.629643Z] Finished install step (success) 07:19:58 INFO - [mozharness: 2017-03-24 14:19:58.629922Z] Running run-tests step. 07:19:58 INFO - Running pre-action listener: _resource_record_pre_action 07:19:58 INFO - Running main action method: run_tests 07:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:58 INFO - Python 2.7.3 07:19:58 INFO - Return code: 0 07:19:58 INFO - grabbing minidump binary from tooltool 07:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:58 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 0x281f400>, '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 0x28203b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2820840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:19:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:19:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:58 INFO - Return code: 0 07:19:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:58 INFO - ENV: RUST_BACKTRACE is now 1 07:19:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:19:58 INFO - Using env: {'DISPLAY': ':0', 07:19:58 INFO - 'HOME': '/home/cltbld', 07:19:58 INFO - 'LANG': 'en_US.UTF-8', 07:19:58 INFO - 'LANGUAGE': 'en_US:en', 07:19:58 INFO - 'LOGNAME': 'cltbld', 07:19:58 INFO - 'MAIL': '/var/mail/cltbld', 07:19:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:58 INFO - 'MOZ_NO_REMOTE': '1', 07:19:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:58 INFO - 'NO_EM_RESTART': '1', 07:19:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:58 INFO - 'PWD': '/builds/slave/test', 07:19:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:58 INFO - 'RUST_BACKTRACE': '1', 07:19:58 INFO - 'SHELL': '/bin/bash', 07:19:58 INFO - 'SHLVL': '1', 07:19:58 INFO - 'TERM': 'linux', 07:19:58 INFO - 'TMOUT': '86400', 07:19:58 INFO - 'USER': 'cltbld', 07:19:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1490365128.822787-1677145202', 07:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:58 INFO - '_': '/tools/buildbot/bin/python'} 07:19:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:19:58 INFO - mozversion application_buildid: 20170324132456 07:19:58 INFO - mozversion application_changeset: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd 07:19:58 INFO - mozversion application_display_name: Nightly 07:19:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:58 INFO - mozversion application_name: Firefox 07:19:58 INFO - mozversion application_remotingname: firefox 07:19:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:19:58 INFO - mozversion application_vendor: Mozilla 07:19:58 INFO - mozversion application_version: 55.0a1 07:19:58 INFO - mozversion platform_buildid: 20170324132456 07:19:58 INFO - mozversion platform_changeset: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd 07:19:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:19:58 INFO - mozversion platform_version: 55.0a1 07:19:58 INFO - using testdate: 1490365198 07:19:58 INFO - actual date: 1490365198 07:19:58 INFO - starting webserver on 'localhost:35984' 07:19:58 INFO - SUITE-START | Running 2 tests 07:19:58 INFO - TEST-START | dromaeo_css 07:19:58 INFO - operating with platform_type : linux_ 07:19:58 INFO - Initialising browser for dromaeo_css test... 07:19:58 INFO - TEST-INFO | started process 4220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskNY4O/profile http://localhost:35984/getInfo.html) 07:20:02 INFO - PID 4220 | __metrics Screen width/height:1600/1200 07:20:02 INFO - PID 4220 | colorDepth:24 07:20:02 INFO - PID 4220 | Browser inner width/height: 1024/697 07:20:02 INFO - PID 4220 | __metrics 07:20:03 INFO - PID 4220 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:20:03 INFO - PID 4220 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:20:04 INFO - TEST-INFO | 4220: exit 0 07:20:04 INFO - Browser initialized. 07:20:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:20:04 INFO - TEST-INFO | started process 4317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskNY4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:16 INFO - PID 4317 | RSS: Main: 145276928 07:20:16 INFO - PID 4317 | 07:23:19 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35984/tests/dromaeo/cssquery-ext.html) 07:23:20 INFO - PID 4317 | RSS: Main: 295268352 07:23:20 INFO - PID 4317 | 07:25:05 INFO - PID 4317 | ************************* 07:25:05 INFO - PID 4317 | A coding exception was thrown and uncaught in a Task. 07:25:05 INFO - PID 4317 | 07:25:05 ERROR - PID 4317 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:25:05 INFO - PID 4317 | Full stack: 07:25:05 INFO - PID 4317 | ************************* 07:26:23 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-ext.html (next: http://localhost:35984/tests/dromaeo/cssquery-jquery.html) 07:26:23 INFO - PID 4317 | RSS: Main: 228413440 07:26:23 INFO - PID 4317 | 07:29:25 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35984/tests/dromaeo/cssquery-mootools.html) 07:29:26 INFO - PID 4317 | RSS: Main: 210272256 07:29:26 INFO - PID 4317 | 07:32:28 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35984/tests/dromaeo/cssquery-prototype.html) 07:32:28 INFO - PID 4317 | RSS: Main: 177889280 07:32:28 INFO - PID 4317 | 07:35:31 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35984/tests/dromaeo/cssquery-yui.html) 07:35:32 INFO - PID 4317 | RSS: Main: 186048512 07:35:32 INFO - PID 4317 | 07:38:34 INFO - PID 4317 | Cycle 1(1): loaded http://localhost:35984/tests/dromaeo/cssquery-yui.html (next: http://localhost:35984/tests/dromaeo/cssquery-dojo.html) 07:38:35 INFO - PID 4317 | RSS: Main: 277364736 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | __start_tp_report 07:38:35 INFO - PID 4317 | _x_x_mozilla_page_load 07:38:35 INFO - PID 4317 | _x_x_mozilla_page_load_details 07:38:35 INFO - PID 4317 | |i|pagename|runs| 07:38:35 INFO - PID 4317 | |0;dojo.html;3270.264190557124;3302.1744563859033;3322.5846769153864;3336.9833150834243;3351.32973405319;5581.386047534768;5642.8307150785495;5648.435156484349;5674.71626418679;5724.22722932404;5604.299462567179;5609.074502707049;5638.182463542794;5663.461971112748;5738.483536481715;4937.382827146606;5026.522480364378;5040.5967522598285;5054.418741844698;5059.772310246048;5032.874178145539;5072.188449848025;5080.618953578478;5087.389513258414;5122.92315615266;5000.42495113063;5010.048090862761;5027.824026159067;5029.572486338666;5074.2895994560795;5079;5080.974595127038;5093.617978651579;5148.433672296044;5154.845354639367;5030.647854650176;5053.772580233898;5054.671446356012;5084.415292241402;5123.897522049576;5471.124620060811;5565.526930210896;5608.747606357683;5632;5644.5484361251;6035.124906888521;6069.696515174223;6120.386183820725;6133.793750436599;6143.726821076186;6069.15031895535;6093.273498128057;6101.176341193926;6136.294326152505;6143.232095988002;5629.915551266734;5647.378788333239;5647.8588035299035;5664.178694089334;5674.148877668383;5989.940100599026;6110.358412366726;6164.630122192593;6219.346968568235;6245.437910588069;5888.146218798251;5949.553783466257;5976.970115149396;5986.970065149646;6030.517558595302;6058.091286307089;6066.181065556093;6072.05883088122;6078.240219972504;6131.785387511416;5924.437178468039;6051.304100028465;6062.666553339609;6062.848428789227;6064.696765161812;5965.73154208053;6006.309274433496;6044.24446944132;6044.304904935901;6049.969750151309;4692.554207350297;4694.178518759203;4695.859124226278;4711.717296962193;4737;4124.319487284624;4136.131412403369;4149.3775933609595;4152.5432202457705;4188.874333769992;5664.54683625309;5718.714064296852;5756.33802112754;5811.215485909433;5867.970660146672;6173.074038894202;6205.906911396332;6211.3167551569295;6217.285012223561;6223.502119830403;5825.088567147257;5837;5849.268841394825;5852.94147058524;5854.648721076749;5004.349434573555;5119.948800512022;5216.817411390583;5256.448072952361;5279.604029697711;6413.326600706859;6426.614403135827;6428.742850285937;6437.871242575028;6441.613503189824;6158.661273629993;6170.5372097092;6171.475424588781;6178.845528861634;6184.350643182401;6166.229221347332;6313.463355614824;6418.229812422539;6430.710618022106;6437.871242575216;5991.131285963598;6002.369751176238;6018.8796224074395;6020.668863212565;6049.66726830011;6123.050927106306;6123.7550497981365;6133.877322453437;6134.478569321479;6136.5090792737365;5822.883542329215;5837.970810146092;5903.144044113666;5904.084866845646;5960.374160713236;5906.734196961061;5916.408359164049;5917.5857689961285;6013.067974463965;6024.367441418588;6008.098785182257;6008.188894499362;6014.669193194416;6016.067509536029;6017.969910150421;6028.57799953999;6028.6985650716415;6037.366076561898;6054.7275372607455;6069.666168360783;5699.544036476989;5718.228039214653;5808.82573522795;5818.854528636818;5827.038538641246 07:38:35 INFO - PID 4317 | |1;ext.html;620.7175735040557;681.3356976947476;695.5478938689853;1133.750574873528;1150.1891166727457;29490.262743431424;37341.253174936486;38012.80993595028;38027.049323766885;38113.237735245275;43181.35227971575;43457;43551.78224108883;43643.56356436435;43778.34332485015;6089.512838972893;6169.969150154243;8279.337652987777;8432.578371081452;8436.873446898302;8010.038795344567;8190.058143313506;8193.877091843628;8195.303399211045;8197.46716463431;8375.706850260241;8482.872756908651;8496.235338819504;8500.829983400328;8503.2347088762;8398.622062007194;8463.23830855226;8463.74608761738;8464.11126831683;8476.533790641512;8286.212809783061;8320.7087751929;8340.37447191463;8348.582570871433;8356.791080222982;41172;41319.173616527805;41538.792306038275;41574.58425415768;41618.58381416177;2934.8532573371244;2948.8673009714616;2949.469095562798;2957.807742496731;2993.6108305920093;26145.084922027636;26355.47289054208;26376;26565.73434265652;28794.856025719946;3639.9272014559824;3649.8905032849057;3653.415453527423;3663.4871118043493;3699.186179040607;179755;183073;183115.0261968559;183195;183217;44938.483919831444;45117;45169;45248.3212751809;45304.54695453003;46821.5317846824;51102.23346649803;51390.74304628528;51423.48576514187;51450.228246576335;15118.924405377902;15351.385944562317;15354.155521446204;15430.691386172213;15517.37930482768;9904.504774761233;9971;11995.280283183038;12582.81125783114;12588.81116783249;14277.857221427861;14280.42878284857;14292.499762508261;14298.142111473346;14302.785458218135;5729.684867332337;5896.233489646404;5903.166480089495;5945.554083443759;5970.940290597038;1015.3400289811682;1040.2718097331897;1041.2398948767443;1044.9634262800766;1062.3041907550567;23403.76596234016;23756.524869502515;23781;23798.405039874142;23805.28584142444;1130.4291332876844;1132.4507613807298;1138.6185627814775;1140.5380820767602;1196.5572738086964;12754.61736147917;12802.487900484062;12805.359732013361;12806.015067664526;12817.102802803714;316403;319264;320841;320874;320987;54744.72627636916;55608;55694.16458753122;55694.16458753122;55745;1440.107133577189;1446.5443385333376;1475.2992328644023;1491.3885307024068;1498.5504348695347;23814;24833.751662483868;25257.74742252554;25282.620760688238;25352.366190845376;39472.21055578815;39559.80220098881;39565.2086958265;39621.80189099036;39654.603453965094;280853;281007;283001;283276;284218;25205.747942521073;25542.23373298804;30220.395592088476;30783.84608077035;33456.1635959103;35882.282354352246;39639;39673.60326396814;39892.20215595614;40904.386434204105;29776.70223297826;30330.696693032787;30369.98332960133;30518.694813051585;30528.236794080327;30496.847515762278;30575;30727.078187654406;31037.534436983013;31621;34827.82586087054;35018.29963400667;35321.823390882884;35811;36049;28967.855160724062;29131.563026555043;29176.27059323534;29395.55906661359;29611.407771844013;23132.421689457897;24141;24682.50634987326;24714.534161490683;24948.12681556137 07:38:35 INFO - PID 4317 | |2;jquery.html;408.92843752343333;412.58329087621496;423.67377119617896;432.9740215587065;433.96094351508367;21057.262995795132;21751.99999999998;21762.129514819408;22171.889140554315;22179.1128354866;22586.54826903461;22757.658635120446;22942;22962.88518557409;23279.185228517006;5815.970920145404;6084.300305464884;6090.48230900374;6103.511719062464;6106.023036314191;5690.231818704463;5910.586258961875;5934.31755348134;5943.108533719934;5944.346121926585;5777.133429985493;5889.381614930435;5901.734421951022;5908.1433192187105;5917.289925208981;5802.071668533035;5909.084091965752;5910.172575839386;5914.319853216892;5915.497182739472;5235.240890070919;5291.312129423189;5311.787528498855;5333.706646134461;5338.786448542053;25509;25540.36149096269;25622.23133305985;25676;25750.227493175236;1992.7309813175325;1995.092233033966;1995.3515107589947;2012.255465477768;2026.9561175994374;15526.61183470411;16531.91734041334;16656.75014874778;16762.916185419115;17055.232514536874;1739.2868923741332;1741.8693597980202;1745.1099939031058;1775.0680892531395;1806.7922188948307;98608;100830;101149;102193.48903255437;102660;11619.593314233962;11698.47356868943;11722.58970936013;11843.28940263587;11968.067823383153;16649.16754162287;16661;16687.165641717864;16702.24839882208;16758.497245082668;8425.915740842636;8441.831163376699;8573;8732;8797.868031979526;8087.878681819778;8094.595270236465;8294.668213271401;8298.626561804733;8299;7600.745876930355;7656.0859785053735;7804;7850.450468467267;7885.290323870764;2024.473636854399;2062.257587268582;2103.7054812326287;2105.8315334773183;2144.324537770597;989.1789814453986;1018.9759291911581;1027.6968294353185;1033.452270296744;1059.3749687684303;20207.797922020887;20394.388168354973;20604;20694.21783596634;20930.267440639505;1044.4777611194402;1046.1630695443614;1058.9622170273021;1069.2354966199205;1071.721352448369;10871.782564348669;12302.692432689255;13307.135036222615;13502.797458038138;13526.850217731602;610358;625205.7232559738;639730;673875;681496;108762.45618772013;110626;110829;112975;114187;1203.8796120387892;1224.5469176404788;1262.6527704881232;1268.2834198677717;1270.3203785974458;19650.90174549118;20817;20879.373618791462;20903.268385606432;21077.473063173544;49804;50738.49261507337;50863;53125;53729;65316.02025969519;65360;65892.34107658862;67359.66320168368;67405;8750.81229692577;8913.28693704515;8926.419782714103;9073.183413492818;9149.496777677025;13689;13834.93082534581;14476.710465790415;15440.691186175989;15669.216539172769;12485.250884946932;12492.25046497213;12680.556180533637;12853.42159602839;13068.607941761762;11323.377214253294;11382.203245773047;12006.879931200576;12186;12210.450529726362;12583.119181657195;12821.615351539469;12834;12883.613491595268;13195.868041319463;8836.602352894006;12559.748805024032;12684.936575317064;13636.727265454834;13656.590302290948;6521.250056243593;12101.878981210075;12471.688207794878;12604.684882878002;12930.935345323212 07:38:35 INFO - PID 4317 | |3;mootools.html;1166.7199872030706;1308.2412200923466;1367.3095086981073;1389.583125062481;1389.99305003475;8977.955110224448;10798.352098874073;10972.177086718488;11054.778904421906;11057.391843448608;10683.358998460099;10771.730706732336;10779.245452818306;10782.946085269563;10783;2006.2677122850127;2230.654248591463;2270.909163633453;2274.9886250568725;2275.601769690306;2096.454921720356;2368.632861906399;2422.8667423291713;2452.705675318964;2453.668754718108;2390.497995420964;2391.545606334791;2397.5324811661735;2397.988010059947;2401.4596715738994;2304.2511183865313;2332.8017118544944;2343.95312093758;2344.34358379654;2365.3613524348416;2358.858468491896;2401.447667036591;2406.6991626046743;2414.541237164933;2415.347856078849;10557.41934193619;10710.839337409945;10720.571177152904;10725.249232553646;10728.195385346053;6393.680315984182;6627.337266273383;6628.038934354539;6629.204495460527;6635.601863888182;3497.6852083312624;3548.183917698944;3773.848906123511;3800.467934489174;3803.9239215215816;1300.505807793042;1335.2255691698792;1340.7184491256849;1385.4804448331874;1397.2594524901817;15618.219089045502;15688.92155539215;15696;15705.921470392803;15716.764248536281;5435.510804027656;5662.348829884616;5710.514606258432;5773.134029895549;5831.650100993869;13723.1079979801;13896.58310250694;13919.443222271198;13921.930390347983;13922.791158132635;6190.102435146879;6413.134226879311;6445.613263204223;6447.194100737408;6467.450266727286;4861.440934292602;4997.85006449807;5795.9420405796245;5801.6519008859605;5805.564582656318;3974.82113304902;4325.783710814447;4375;4449.1101779644205;4463.285874260103;1351.3175846197607;1384.6815232496583;1391.3669280477359;1401.0402874031322;1413.4487549855564;831.4387788243033;854.3592305770673;860.8751730999095;879.4767113567417;879.612970293069;6182.28903676083;6267.968660156761;6468.68480646968;6491.383318584727;6509.1863517060365;922.4741897118712;952.4523399045577;953.5041778275258;953.8521529162991;963.710886733977;4293.828246870153;4501.122281155143;4521.954780452219;4595.655325850575;4647.140279048387;14235.43058277678;14651.633709157357;14658.19379934114;14659.706805863823;14704.044237124766;14126.152430853976;14763.77854332186;14767.26163691811;14771;14780.113193208443;10544.209184311207;10553.102986246102;10586.523606437575;10609.310394824312;10713.625023124154;6561.573497722633;6728.05807187004;6754.5609535380045;6766.729330826712;6778.32216778338;12680.112392132462;12803.10378273512;13119.540816071392;13144;13177.077604567972;12704.491820327083;13262.204267743966;13263.734725305247;13454.52909148175;13509.568277709714;8894.86657700148;9022.684206052756;9107.08929107084;9112.95443522778;9113.453192808453;9711.077447642463;9714.3199976001;9717.319787614799;9774.902250977399;9822.214222862296;8496.617652205789;8611.224989750952;8631.654733810828;8703.695370661997;8893.510856902933;8617.095205003385;8664.176903194439;8700.56497175126;8759.956200218958;8950.060243674321;7725.652345644347;7727;7742.690292388242;7751.6511756972195;7774.067111946377;5863.589548731547;5911.881762364815;5970.104484327386;6042.214512113573;6183.752649893954;6015.939840601538;6072.423119803611;6161.322254551906;6192.535559832941;6315.747410064096 07:38:35 INFO - PID 4317 | |4;prototype.html;365.76590981771653;384.9384098544232;388.0879932159424;405.9086705491265;411.78998710657567;5747.913781293284;5931.703414829258;5973.4623883850445;5992.531829701724;5997.130416089664;5772.5670574706955;5817.709114544266;5830.09633506806;5830.7084645767645;5835.124731290298;4490.820367185309;4496.415465989417;4506.053728716974;4508.97745511272;4519.977400113011;4301.139772045603;4465.598096171344;4474.507804141542;4513.480949690778;4516.074204788027;4430.446194225722;4434.645228381722;4435.667324950641;4441.62246209071;4442.533533978934;4433.157700036999;4440.26829536481;4455.376247325377;4455.777211139462;4487.798049087799;3713.16453797896;3815.561210460805;3939.98030009851;3941.1526521797664;3958.366661334173;5673.220122140163;5682.204491371212;5705.657660540381;5709.743061562198;5719;5144.254083157958;5156.097682905476;5166.483351664803;5168.457311982263;5183.092958732207;6045.23482723639;6045.244344456943;6074.726637301332;6167.599106058092;6178.949578571654;4314.158739045856;4314.892127696801;4328.900483265646;4334.089841133366;4337.327714204272;6160.969195154041;6222.81331560054;6324.810255692382;6479.1901012373455;6560.376764207393;4396.890077748082;4424.823007079745;4425.114977004548;4437.600615944581;4442.8004438801345;4468.977655111704;4497;4512.435945506812;4519.141363140992;4521.5930566248535;5010.473900240495;5134;5174.120399532088;5194.714290714047;5214.243934629458;6231.532635052389;6236.345183755731;6245.125682404467;6253.343398943137;6260.968695156495;1531.6783475470054;1558.2754019381043;1559.7288210108725;1563.3121426572272;1580.6364536156748;1007.4811472091878;1047.7694907120422;1055;1056.0917610854658;1063.6011495689118;5985.610935289279;6001.099835024781;6004.819855404345;6031.2159419276095;6033.245844269466;6203.689815509207;6373.330800265998;6374.872502550016;6427.807165785034;6429.7749578764515;5971.20863740876;5972.731227094791;6022.5483088768515;6047.909281360783;6055.969720151459;3304.7521435892404;3357.2949680567353;3388.4409072503254;3397.7451691123265;3399.6600339965808;6369.076483909807;6701.1623547056615;6737.52837301394;6748.156480439945;6805.795826125224;6524.347565243438;6567.868642627216;6572.737090516326;6582.835429114215;6587.440067594212;6398.584092034003;6678.465722742072;6678.49911256648;6770.69531871067;6805.3875151236625;6382.393672601095;6385.786700526885;6391.904121438275;6398.48812095022;6441;6130.233720784902;6276.121343012073;6328;6359.109724638647;6402.93597064042;6662.100616416722;6667.533272670867;6673.431743540361;6712.496562757715;6749.502684006752;4440.777961101997;4446.666500012448;4452.688311818141;4470.061287129739;4474.709143905636;6006.9576344043235;6347.301796802256;6399.816034033719;6453.903191452038;6463.3213512580505;6237.719302631302;6239.594426362272;6242.563020588515;6242.7514497099855;6259.7167580646765;6151.477124444473;6224.688765561795;6231.881160405484;6242.5942313749465;6271.3728627136925;6175.197224360804;6188.535859810442;6192.690365481798;6216.725571257791;6219.253689557282;6092.634441933498;6231.2522497298805;6247.406496382836;6281.560290779785;6287.182666253358;6071.089336599545;6085.817425477243;6095.847603809762;6097.420745029215;6115.847103822262 07:38:35 INFO - PID 4317 | |5;yui.html;766.2643861892583;771.9228077192281;776.5146783260462;782.4131901074194;788.5702292250725;14767.556973290792;14793.704125917475;14885.92557037216;14944.327505262263;14973.700525989474;14917.254137293146;14929.7014059719;15064.246787660628;15083.245837708098;15095.169765662884;813.9145389734082;841.3017195727562;842.4061036968952;844.7339088187232;845.1252953193446;837.7109897085496;843.3464065349373;845.0366582096415;845.5687599324358;846.2764336492303;873.2751815992742;877.7103555826562;878.8505953987806;878.8549889268263;880.3353468131584;868.7480630617114;869.0223498564116;880.7049638371153;885.2165833237567;885.8804061451686;643.8165122939939;644.4876323322969;645.4320198225531;645.9644719540423;646.5894157210158;16531.752023719655;16998.00546871484;17058.573535661584;17086.829131708648;17530;15179.392824287015;15281.923590381977;15296.158711270988;15440.922795385952;16074.517764467084;12393.442295096742;12626.494940202381;12633.11568190227;12673.746525069539;12709.936450317782;3207.903762887117;3260.315333779909;3321.186309354224;3342.147752323142;3386.3058073095203;86995.56502217511;87121.56439217764;88315;90374;90776;11761;11883.227590206609;12151.331676757864;12175.634730958085;12186;22140.55718885613;24377.756222437903;24398.146064888;24597.754022459903;24664.260072197863;7866.646000929972;8023.879641805378;8122.431429799975;8151.307138893142;8196.590170491452;3994.862614611802;4017.276890159741;4074.2258970795456;4078.6737061035046;4159.376093585986;4225.556316586775;4235;4241.236577416094;4276.123394704078;4299.032717638569;823.9011318641801;826.5949684654596;835.2107258640648;838.9706360277484;850.9702160424356;640.9583377080475;646.4602057282128;653.0922018394435;660.6102399584269;676.4993904510725;10366.637167699095;10974.835377469344;11118.277311974696;11121.332720036824;11271.492782824793;627.1282916745727;645.95155363347;652.1945397434165;652.7323797243107;657.7960832142052;4599.264117741145;4932.8766780830765;4935.111679897653;4950.356453661001;4951.603871690256;77379.61310193413;77462.6126869362;78308.60845695736;79493;80736.59631701803;69023.30976690169;69525.65237173781;70483;71297.64351178211;73953.6302318485;61746.69126654338;61890.38109618936;62081;62230;63902.041469378;9477.857832132386;9693;9718.611255549982;9748;9777.951110244403;32955.8352208247;33143.50284745779;33186.33627327488;33688.49467257944;34479.655203448645;40096.39855402229;40562.39156412715;40696.38955415612;50511.49488505068;51052.10796542419;13351.79972300397;14320.283985800459;14352;14448.27758612044;14799.482018129744;14057.22685252321;15308.617284567976;15862.603434913757;16256.43102491407;16820.831791681925;14445.422183112558;15306.08163510193;15366.769498457308;15620;15848.44530441429;13582.388792504558;14506.85493145055;14582.125072495684;14926.179060151795;15159.166245856142;13361.064725469123;14027.719445611236;14186.503472378417;14553.19957402353;14612.488562900247;10686.305390149615;10971.177161712743;11127.054200393057;11185.66443006711;11243.55025798959;11165;11395.430228488709;12266.07189975254;12468.127231093737;12626.936865315614 07:38:35 INFO - PID 4317 | __end_tp_report 07:38:35 INFO - PID 4317 | __start_cc_report 07:38:35 INFO - PID 4317 | _x_x_mozilla_cycle_collect,1604 07:38:35 INFO - PID 4317 | __end_cc_report 07:38:35 INFO - PID 4317 | __startTimestamp1490366315188__endTimestamp 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | ------- Summary: start ------- 07:38:35 INFO - PID 4317 | Number of tests: 6 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#0] dojo.html Cycles:165 Average:5643.94 Median:5888.15 stddev:662.50 (11.3%) stddev-sans-first:637.82 07:38:35 INFO - PID 4317 | Values: 3270.3 3302.2 3322.6 3337.0 3351.3 5581.4 5642.8 5648.4 5674.7 5724.2 5604.3 5609.1 5638.2 5663.5 5738.5 4937.4 5026.5 5040.6 5054.4 5059.8 5032.9 5072.2 5080.6 5087.4 5122.9 5000.4 5010.0 5027.8 5029.6 5074.3 5079.0 5081.0 5093.6 5148.4 5154.8 5030.6 5053.8 5054.7 5084.4 5123.9 5471.1 5565.5 5608.7 5632.0 5644.5 6035.1 6069.7 6120.4 6133.8 6143.7 6069.2 6093.3 6101.2 6136.3 6143.2 5629.9 5647.4 5647.9 5664.2 5674.1 5989.9 6110.4 6164.6 6219.3 6245.4 5888.1 5949.6 5977.0 5987.0 6030.5 6058.1 6066.2 6072.1 6078.2 6131.8 5924.4 6051.3 6062.7 6062.8 6064.7 5965.7 6006.3 6044.2 6044.3 6050.0 4692.6 4694.2 4695.9 4711.7 4737.0 4124.3 4136.1 4149.4 4152.5 4188.9 5664.5 5718.7 5756.3 5811.2 5868.0 6173.1 6205.9 6211.3 6217.3 6223.5 5825.1 5837.0 5849.3 5852.9 5854.6 5004.3 5119.9 5216.8 5256.4 5279.6 6413.3 6426.6 6428.7 6437.9 6441.6 6158.7 6170.5 6171.5 6178.8 6184.4 6166.2 6313.5 6418.2 6430.7 6437.9 5991.1 6002.4 6018.9 6020.7 6049.7 6123.1 6123.8 6133.9 6134.5 6136.5 5822.9 5838.0 5903.1 5904.1 5960.4 5906.7 5916.4 5917.6 6013.1 6024.4 6008.1 6008.2 6014.7 6016.1 6018.0 6028.6 6028.7 6037.4 6054.7 6069.7 5699.5 5718.2 5808.8 5818.9 5827.0 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#1] ext.html Cycles:180 Average:41724.97 Median:317833.50 stddev:70271.00 (22.1%) stddev-sans-first:70400.36 07:38:35 INFO - PID 4317 | Values: 620.7 681.3 695.5 1133.8 1150.2 29490.3 37341.3 38012.8 38027.0 38113.2 43181.4 43457.0 43551.8 43643.6 43778.3 6089.5 6170.0 8279.3 8432.6 8436.9 8010.0 8190.1 8193.9 8195.3 8197.5 8375.7 8482.9 8496.2 8500.8 8503.2 8398.6 8463.2 8463.7 8464.1 8476.5 8286.2 8320.7 8340.4 8348.6 8356.8 41172.0 41319.2 41538.8 41574.6 41618.6 2934.9 2948.9 2949.5 2957.8 2993.6 26145.1 26355.5 26376.0 26565.7 28794.9 3639.9 3649.9 3653.4 3663.5 3699.2 179755.0 183073.0 183115.0 183195.0 183217.0 44938.5 45117.0 45169.0 45248.3 45304.5 46821.5 51102.2 51390.7 51423.5 51450.2 15118.9 15351.4 15354.2 15430.7 15517.4 9904.5 9971.0 11995.3 12582.8 12588.8 14277.9 14280.4 14292.5 14298.1 14302.8 5729.7 5896.2 5903.2 5945.6 5970.9 1015.3 1040.3 1041.2 1045.0 1062.3 23403.8 23756.5 23781.0 23798.4 23805.3 1130.4 1132.5 1138.6 1140.5 1196.6 12754.6 12802.5 12805.4 12806.0 12817.1 316403.0 319264.0 320841.0 320874.0 320987.0 54744.7 55608.0 55694.2 55694.2 55745.0 1440.1 1446.5 1475.3 1491.4 1498.6 23814.0 24833.8 25257.7 25282.6 25352.4 39472.2 39559.8 39565.2 39621.8 39654.6 280853.0 281007.0 283001.0 283276.0 284218.0 25205.7 25542.2 30220.4 30783.8 33456.2 35882.3 39639.0 39673.6 39892.2 40904.4 29776.7 30330.7 30370.0 30518.7 30528.2 30496.8 30575.0 30727.1 31037.5 31621.0 34827.8 35018.3 35321.8 35811.0 36049.0 28967.9 29131.6 29176.3 29395.6 29611.4 23132.4 24141.0 24682.5 24714.5 24948.1 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#2] jquery.html Cycles:180 Average:35932.93 Median:20916.77 stddev:106528.35 (509.3%) stddev-sans-first:106793.80 07:38:35 INFO - PID 4317 | Values: 408.9 412.6 423.7 433.0 434.0 21057.3 21752.0 21762.1 22171.9 22179.1 22586.5 22757.7 22942.0 22962.9 23279.2 5816.0 6084.3 6090.5 6103.5 6106.0 5690.2 5910.6 5934.3 5943.1 5944.3 5777.1 5889.4 5901.7 5908.1 5917.3 5802.1 5909.1 5910.2 5914.3 5915.5 5235.2 5291.3 5311.8 5333.7 5338.8 25509.0 25540.4 25622.2 25676.0 25750.2 1992.7 1995.1 1995.4 2012.3 2027.0 15526.6 16531.9 16656.8 16762.9 17055.2 1739.3 1741.9 1745.1 1775.1 1806.8 98608.0 100830.0 101149.0 102193.5 102660.0 11619.6 11698.5 11722.6 11843.3 11968.1 16649.2 16661.0 16687.2 16702.2 16758.5 8425.9 8441.8 8573.0 8732.0 8797.9 8087.9 8094.6 8294.7 8298.6 8299.0 7600.7 7656.1 7804.0 7850.5 7885.3 2024.5 2062.3 2103.7 2105.8 2144.3 989.2 1019.0 1027.7 1033.5 1059.4 20207.8 20394.4 20604.0 20694.2 20930.3 1044.5 1046.2 1059.0 1069.2 1071.7 10871.8 12302.7 13307.1 13502.8 13526.9 610358.0 625205.7 639730.0 673875.0 681496.0 108762.5 110626.0 110829.0 112975.0 114187.0 1203.9 1224.5 1262.7 1268.3 1270.3 19650.9 20817.0 20879.4 20903.3 21077.5 49804.0 50738.5 50863.0 53125.0 53729.0 65316.0 65360.0 65892.3 67359.7 67405.0 8750.8 8913.3 8926.4 9073.2 9149.5 13689.0 13834.9 14476.7 15440.7 15669.2 12485.3 12492.3 12680.6 12853.4 13068.6 11323.4 11382.2 12006.9 12186.0 12210.5 12583.1 12821.6 12834.0 12883.6 13195.9 8836.6 12559.7 12684.9 13636.7 13656.6 6521.3 12101.9 12471.7 12604.7 12930.9 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#3] mootools.html Cycles:180 Average:6973.07 Median:3661.02 stddev:4408.92 (120.4%) stddev-sans-first:4399.69 07:38:35 INFO - PID 4317 | Values: 1166.7 1308.2 1367.3 1389.6 1390.0 8978.0 10798.4 10972.2 11054.8 11057.4 10683.4 10771.7 10779.2 10782.9 10783.0 2006.3 2230.7 2270.9 2275.0 2275.6 2096.5 2368.6 2422.9 2452.7 2453.7 2390.5 2391.5 2397.5 2398.0 2401.5 2304.3 2332.8 2344.0 2344.3 2365.4 2358.9 2401.4 2406.7 2414.5 2415.3 10557.4 10710.8 10720.6 10725.2 10728.2 6393.7 6627.3 6628.0 6629.2 6635.6 3497.7 3548.2 3773.8 3800.5 3803.9 1300.5 1335.2 1340.7 1385.5 1397.3 15618.2 15688.9 15696.0 15705.9 15716.8 5435.5 5662.3 5710.5 5773.1 5831.7 13723.1 13896.6 13919.4 13921.9 13922.8 6190.1 6413.1 6445.6 6447.2 6467.5 4861.4 4997.9 5795.9 5801.7 5805.6 3974.8 4325.8 4375.0 4449.1 4463.3 1351.3 1384.7 1391.4 1401.0 1413.4 831.4 854.4 860.9 879.5 879.6 6182.3 6268.0 6468.7 6491.4 6509.2 922.5 952.5 953.5 953.9 963.7 4293.8 4501.1 4522.0 4595.7 4647.1 14235.4 14651.6 14658.2 14659.7 14704.0 14126.2 14763.8 14767.3 14771.0 14780.1 10544.2 10553.1 10586.5 10609.3 10713.6 6561.6 6728.1 6754.6 6766.7 6778.3 12680.1 12803.1 13119.5 13144.0 13177.1 12704.5 13262.2 13263.7 13454.5 13509.6 8894.9 9022.7 9107.1 9113.0 9113.5 9711.1 9714.3 9717.3 9774.9 9822.2 8496.6 8611.2 8631.7 8703.7 8893.5 8617.1 8664.2 8700.6 8760.0 8950.1 7725.7 7727.0 7742.7 7751.7 7774.1 5863.6 5911.9 5970.1 6042.2 6183.8 6015.9 6072.4 6161.3 6192.5 6315.7 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#4] prototype.html Cycles:180 Average:5201.66 Median:5989.07 stddev:1566.88 (26.2%) stddev-sans-first:1528.65 07:38:35 INFO - PID 4317 | Values: 365.8 384.9 388.1 405.9 411.8 5747.9 5931.7 5973.5 5992.5 5997.1 5772.6 5817.7 5830.1 5830.7 5835.1 4490.8 4496.4 4506.1 4509.0 4520.0 4301.1 4465.6 4474.5 4513.5 4516.1 4430.4 4434.6 4435.7 4441.6 4442.5 4433.2 4440.3 4455.4 4455.8 4487.8 3713.2 3815.6 3940.0 3941.2 3958.4 5673.2 5682.2 5705.7 5709.7 5719.0 5144.3 5156.1 5166.5 5168.5 5183.1 6045.2 6045.2 6074.7 6167.6 6178.9 4314.2 4314.9 4328.9 4334.1 4337.3 6161.0 6222.8 6324.8 6479.2 6560.4 4396.9 4424.8 4425.1 4437.6 4442.8 4469.0 4497.0 4512.4 4519.1 4521.6 5010.5 5134.0 5174.1 5194.7 5214.2 6231.5 6236.3 6245.1 6253.3 6261.0 1531.7 1558.3 1559.7 1563.3 1580.6 1007.5 1047.8 1055.0 1056.1 1063.6 5985.6 6001.1 6004.8 6031.2 6033.2 6203.7 6373.3 6374.9 6427.8 6429.8 5971.2 5972.7 6022.5 6047.9 6056.0 3304.8 3357.3 3388.4 3397.7 3399.7 6369.1 6701.2 6737.5 6748.2 6805.8 6524.3 6567.9 6572.7 6582.8 6587.4 6398.6 6678.5 6678.5 6770.7 6805.4 6382.4 6385.8 6391.9 6398.5 6441.0 6130.2 6276.1 6328.0 6359.1 6402.9 6662.1 6667.5 6673.4 6712.5 6749.5 4440.8 4446.7 4452.7 4470.1 4474.7 6007.0 6347.3 6399.8 6453.9 6463.3 6237.7 6239.6 6242.6 6242.8 6259.7 6151.5 6224.7 6231.9 6242.6 6271.4 6175.2 6188.5 6192.7 6216.7 6219.3 6092.6 6231.3 6247.4 6281.6 6287.2 6071.1 6085.8 6095.8 6097.4 6115.8 07:38:35 INFO - PID 4317 | 07:38:35 INFO - PID 4317 | [#5] yui.html Cycles:180 Average:17748.19 Median:4076.45 stddev:22640.01 (555.4%) stddev-sans-first:22667.61 07:38:35 INFO - PID 4317 | Values: 766.3 771.9 776.5 782.4 788.6 14767.6 14793.7 14885.9 14944.3 14973.7 14917.3 14929.7 15064.2 15083.2 15095.2 813.9 841.3 842.4 844.7 845.1 837.7 843.3 845.0 845.6 846.3 873.3 877.7 878.9 878.9 880.3 868.7 869.0 880.7 885.2 885.9 643.8 644.5 645.4 646.0 646.6 16531.8 16998.0 17058.6 17086.8 17530.0 15179.4 15281.9 15296.2 15440.9 16074.5 12393.4 12626.5 12633.1 12673.7 12709.9 3207.9 3260.3 3321.2 3342.1 3386.3 86995.6 87121.6 88315.0 90374.0 90776.0 11761.0 11883.2 12151.3 12175.6 12186.0 22140.6 24377.8 24398.1 24597.8 24664.3 7866.6 8023.9 8122.4 8151.3 8196.6 3994.9 4017.3 4074.2 4078.7 4159.4 4225.6 4235.0 4241.2 4276.1 4299.0 823.9 826.6 835.2 839.0 851.0 641.0 646.5 653.1 660.6 676.5 10366.6 10974.8 11118.3 11121.3 11271.5 627.1 646.0 652.2 652.7 657.8 4599.3 4932.9 4935.1 4950.4 4951.6 77379.6 77462.6 78308.6 79493.0 80736.6 69023.3 69525.7 70483.0 71297.6 73953.6 61746.7 61890.4 62081.0 62230.0 63902.0 9477.9 9693.0 9718.6 9748.0 9778.0 32955.8 33143.5 33186.3 33688.5 34479.7 40096.4 40562.4 40696.4 50511.5 51052.1 13351.8 14320.3 14352.0 14448.3 14799.5 14057.2 15308.6 15862.6 16256.4 16820.8 14445.4 15306.1 15366.8 15620.0 15848.4 13582.4 14506.9 14582.1 14926.2 15159.2 13361.1 14027.7 14186.5 14553.2 14612.5 10686.3 10971.2 11127.1 11185.7 11243.6 11165.0 11395.4 12266.1 12468.1 12626.9 07:38:35 INFO - PID 4317 | -------- Summary: end -------- 07:38:35 INFO - PID 4317 | 07:38:36 INFO - TEST-INFO | 4317: exit 0 07:38:36 INFO - TEST-OK | dromaeo_css | took 1117107ms 07:38:36 INFO - TEST-START | kraken 07:38:36 INFO - operating with platform_type : linux_ 07:38:36 INFO - Initialising browser for kraken test... 07:38:36 INFO - TEST-INFO | started process 4680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoH7l3u/profile http://localhost:35984/getInfo.html) 07:38:39 INFO - PID 4680 | __metrics Screen width/height:1600/1200 07:38:39 INFO - PID 4680 | colorDepth:24 07:38:39 INFO - PID 4680 | Browser inner width/height: 1024/697 07:38:39 INFO - PID 4680 | __metrics 07:38:40 INFO - PID 4680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:40 INFO - PID 4680 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:41 INFO - TEST-INFO | 4680: exit 0 07:38:41 INFO - Browser initialized. 07:38:41 INFO - Running cycle 1/1 for kraken test... 07:38:41 INFO - TEST-INFO | started process 4773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoH7l3u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:53 INFO - PID 4773 | RSS: Main: 145182720 07:38:53 INFO - PID 4773 | 07:38:56 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:57 INFO - PID 4773 | RSS: Main: 200847360 07:38:57 INFO - PID 4773 | 07:38:59 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-dft) 07:39:00 INFO - PID 4773 | RSS: Main: 179994624 07:39:00 INFO - PID 4773 | 07:39:03 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-fft) 07:39:03 INFO - PID 4773 | RSS: Main: 261607424 07:39:03 INFO - PID 4773 | 07:39:05 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35984/tests/kraken/driver.html?testName=audio-oscillator) 07:39:06 INFO - PID 4773 | RSS: Main: 173359104 07:39:06 INFO - PID 4773 | 07:39:08 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:39:09 INFO - PID 4773 | RSS: Main: 176803840 07:39:09 INFO - PID 4773 | 07:39:12 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-darkroom) 07:39:12 INFO - PID 4773 | RSS: Main: 214994944 07:39:12 INFO - PID 4773 | 07:39:16 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35984/tests/kraken/driver.html?testName=imaging-desaturate) 07:39:16 INFO - PID 4773 | RSS: Main: 227454976 07:39:16 INFO - PID 4773 | 07:39:19 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35984/tests/kraken/driver.html?testName=json-parse-financial) 07:39:20 INFO - PID 4773 | RSS: Main: 237596672 07:39:20 INFO - PID 4773 | 07:39:21 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:39:22 INFO - PID 4773 | RSS: Main: 178434048 07:39:22 INFO - PID 4773 | 07:39:24 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:24 INFO - PID 4773 | RSS: Main: 185683968 07:39:24 INFO - PID 4773 | 07:39:26 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:27 INFO - PID 4773 | RSS: Main: 194465792 07:39:27 INFO - PID 4773 | 07:39:29 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:30 INFO - PID 4773 | RSS: Main: 203436032 07:39:30 INFO - PID 4773 | 07:39:33 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:34 INFO - PID 4773 | RSS: Main: 200318976 07:39:34 INFO - PID 4773 | 07:39:35 INFO - PID 4773 | Cycle 1(1): loaded http://localhost:35984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35984/tests/kraken/driver.html?testName=ai-astar) 07:39:36 INFO - PID 4773 | RSS: Main: 268427264 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | __start_tp_report 07:39:36 INFO - PID 4773 | _x_x_mozilla_page_load 07:39:36 INFO - PID 4773 | _x_x_mozilla_page_load_details 07:39:36 INFO - PID 4773 | |i|pagename|runs| 07:39:36 INFO - PID 4773 | |0;ai-astar;101;110;109;108;110;108;110;109;108;109 07:39:36 INFO - PID 4773 | |1;audio-beat-detection;150;118;118;157;118;124;117;122;141;124 07:39:36 INFO - PID 4773 | |2;audio-dft;163;162;161;162;162;164;163;161;162;162 07:39:36 INFO - PID 4773 | |3;audio-fft;73;74;76;109;76;74;74;74;101;74 07:39:36 INFO - PID 4773 | |4;audio-oscillator;83;83;110;82;83;83;101;84;83;101 07:39:36 INFO - PID 4773 | |5;imaging-gaussian-blur;113;113;113;112;113;113;114;113;113;113 07:39:36 INFO - PID 4773 | |6;imaging-darkroom;146;147;146;147;146;147;146;146;146;147 07:39:36 INFO - PID 4773 | |7;imaging-desaturate;94;94;94;95;94;94;94;94;95;94 07:39:36 INFO - PID 4773 | |8;json-parse-financial;62;56;58;57;58;57;57;59;57;58 07:39:36 INFO - PID 4773 | |9;json-stringify-tinderbox;55;54;54;54;55;54;54;55;54;54 07:39:36 INFO - PID 4773 | |10;stanford-crypto-aes;87;87;80;79;79;79;79;79;79;77 07:39:36 INFO - PID 4773 | |11;stanford-crypto-ccm;127;133;128;131;124;136;132;133;175;131 07:39:36 INFO - PID 4773 | |12;stanford-crypto-pbkdf2;184;191;182;184;181;181;180;177;184;187 07:39:36 INFO - PID 4773 | |13;stanford-crypto-sha256-iterative;64;65;66;64;66;66;65;66;67;67 07:39:36 INFO - PID 4773 | __end_tp_report 07:39:36 INFO - PID 4773 | __start_cc_report 07:39:36 INFO - PID 4773 | _x_x_mozilla_cycle_collect,1706 07:39:36 INFO - PID 4773 | __end_cc_report 07:39:36 INFO - PID 4773 | __startTimestamp1490366376211__endTimestamp 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | ------- Summary: start ------- 07:39:36 INFO - PID 4773 | Number of tests: 14 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 07:39:36 INFO - PID 4773 | Values: 101.0 110.0 109.0 108.0 110.0 108.0 110.0 109.0 108.0 109.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:124.00 stddev:14.81 (11.9%) stddev-sans-first:13.60 07:39:36 INFO - PID 4773 | Values: 150.0 118.0 118.0 157.0 118.0 124.0 117.0 122.0 141.0 124.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 07:39:36 INFO - PID 4773 | Values: 163.0 162.0 161.0 162.0 162.0 164.0 163.0 161.0 162.0 162.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:13.08 (17.7%) stddev-sans-first:13.59 07:39:36 INFO - PID 4773 | Values: 73.0 74.0 76.0 109.0 76.0 74.0 74.0 74.0 101.0 74.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:10.45 (12.6%) stddev-sans-first:10.83 07:39:36 INFO - PID 4773 | Values: 83.0 83.0 110.0 82.0 83.0 83.0 101.0 84.0 83.0 101.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:39:36 INFO - PID 4773 | Values: 113.0 113.0 113.0 112.0 113.0 113.0 114.0 113.0 113.0 113.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:39:36 INFO - PID 4773 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:39:36 INFO - PID 4773 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.66 (2.9%) stddev-sans-first:0.88 07:39:36 INFO - PID 4773 | Values: 62.0 56.0 58.0 57.0 58.0 57.0 57.0 59.0 57.0 58.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 07:39:36 INFO - PID 4773 | Values: 55.0 54.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.00 stddev:3.50 (4.4%) stddev-sans-first:2.82 07:39:36 INFO - PID 4773 | Values: 87.0 87.0 80.0 79.0 79.0 79.0 79.0 79.0 79.0 77.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:132.50 stddev:14.47 (10.9%) stddev-sans-first:15.05 07:39:36 INFO - PID 4773 | Values: 127.0 133.0 128.0 131.0 124.0 136.0 132.0 133.0 175.0 131.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:184.00 stddev:3.90 (2.1%) stddev-sans-first:4.12 07:39:36 INFO - PID 4773 | Values: 184.0 191.0 182.0 184.0 181.0 181.0 180.0 177.0 184.0 187.0 07:39:36 INFO - PID 4773 | 07:39:36 INFO - PID 4773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 07:39:36 INFO - PID 4773 | Values: 64.0 65.0 66.0 64.0 66.0 66.0 65.0 66.0 67.0 67.0 07:39:36 INFO - PID 4773 | -------- Summary: end -------- 07:39:36 INFO - PID 4773 | 07:39:37 INFO - TEST-INFO | 4773: exit 0 07:39:37 INFO - TEST-OK | kraken | took 61270ms 07:39:37 INFO - SUITE-END | took 1178s 07:39:37 INFO - Completed test suite (00:19:38) 07:39:37 INFO - javascript benchmark 07:39:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7533.08699028537, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.264190557124, 3302.1744563859033, 3322.5846769153864, 3336.9833150834243, 3351.32973405319, 5581.386047534768, 5642.8307150785495, 5648.435156484349, 5674.71626418679, 5724.22722932404, 5604.299462567179, 5609.074502707049, 5638.182463542794, 5663.461971112748, 5738.483536481715, 4937.382827146606, 5026.522480364378, 5040.5967522598285, 5054.418741844698, 5059.772310246048, 5032.874178145539, 5072.188449848025, 5080.618953578478, 5087.389513258414, 5122.92315615266, 5000.42495113063, 5010.048090862761, 5027.824026159067, 5029.572486338666, 5074.2895994560795, 5079.0, 5080.974595127038, 5093.617978651579, 5148.433672296044, 5154.845354639367, 5030.647854650176, 5053.772580233898, 5054.671446356012, 5084.415292241402, 5123.897522049576, 5471.124620060811, 5565.526930210896, 5608.747606357683, 5632.0, 5644.5484361251, 6035.124906888521, 6069.696515174223, 6120.386183820725, 6133.793750436599, 6143.726821076186, 6069.15031895535, 6093.273498128057, 6101.176341193926, 6136.294326152505, 6143.232095988002, 5629.915551266734, 5647.378788333239, 5647.8588035299035, 5664.178694089334, 5674.148877668383, 5989.940100599026, 6110.358412366726, 6164.630122192593, 6219.346968568235, 6245.437910588069, 5888.146218798251, 5949.553783466257, 5976.970115149396, 5986.970065149646, 6030.517558595302, 6058.091286307089, 6066.181065556093, 6072.05883088122, 6078.240219972504, 6131.785387511416, 5924.437178468039, 6051.304100028465, 6062.666553339609, 6062.848428789227, 6064.696765161812, 5965.73154208053, 6006.309274433496, 6044.24446944132, 6044.304904935901, 6049.969750151309, 4692.554207350297, 4694.178518759203, 4695.859124226278, 4711.717296962193, 4737.0, 4124.319487284624, 4136.131412403369, 4149.3775933609595, 4152.5432202457705, 4188.874333769992, 5664.54683625309, 5718.714064296852, 5756.33802112754, 5811.215485909433, 5867.970660146672, 6173.074038894202, 6205.906911396332, 6211.3167551569295, 6217.285012223561, 6223.502119830403, 5825.088567147257, 5837.0, 5849.268841394825, 5852.94147058524, 5854.648721076749, 5004.349434573555, 5119.948800512022, 5216.817411390583, 5256.448072952361, 5279.604029697711, 6413.326600706859, 6426.614403135827, 6428.742850285937, 6437.871242575028, 6441.613503189824, 6158.661273629993, 6170.5372097092, 6171.475424588781, 6178.845528861634, 6184.350643182401, 6166.229221347332, 6313.463355614824, 6418.229812422539, 6430.710618022106, 6437.871242575216, 5991.131285963598, 6002.369751176238, 6018.8796224074395, 6020.668863212565, 6049.66726830011, 6123.050927106306, 6123.7550497981365, 6133.877322453437, 6134.478569321479, 6136.5090792737365, 5822.883542329215, 5837.970810146092, 5903.144044113666, 5904.084866845646, 5960.374160713236, 5906.734196961061, 5916.408359164049, 5917.5857689961285, 6013.067974463965, 6024.367441418588, 6008.098785182257, 6008.188894499362, 6014.669193194416, 6016.067509536029, 6017.969910150421, 6028.57799953999, 6028.6985650716415, 6037.366076561898, 6054.7275372607455, 6069.666168360783, 5699.544036476989, 5718.228039214653, 5808.82573522795, 5818.854528636818, 5827.038538641246], "value": 5598.421843918642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.7175735040557, 681.3356976947476, 695.5478938689853, 1133.750574873528, 1150.1891166727457, 29490.262743431424, 37341.253174936486, 38012.80993595028, 38027.049323766885, 38113.237735245275, 43181.35227971575, 43457.0, 43551.78224108883, 43643.56356436435, 43778.34332485015, 6089.512838972893, 6169.969150154243, 8279.337652987777, 8432.578371081452, 8436.873446898302, 8010.038795344567, 8190.058143313506, 8193.877091843628, 8195.303399211045, 8197.46716463431, 8375.706850260241, 8482.872756908651, 8496.235338819504, 8500.829983400328, 8503.2347088762, 8398.622062007194, 8463.23830855226, 8463.74608761738, 8464.11126831683, 8476.533790641512, 8286.212809783061, 8320.7087751929, 8340.37447191463, 8348.582570871433, 8356.791080222982, 41172.0, 41319.173616527805, 41538.792306038275, 41574.58425415768, 41618.58381416177, 2934.8532573371244, 2948.8673009714616, 2949.469095562798, 2957.807742496731, 2993.6108305920093, 26145.084922027636, 26355.47289054208, 26376.0, 26565.73434265652, 28794.856025719946, 3639.9272014559824, 3649.8905032849057, 3653.415453527423, 3663.4871118043493, 3699.186179040607, 179755.0, 183073.0, 183115.0261968559, 183195.0, 183217.0, 44938.483919831444, 45117.0, 45169.0, 45248.3212751809, 45304.54695453003, 46821.5317846824, 51102.23346649803, 51390.74304628528, 51423.48576514187, 51450.228246576335, 15118.924405377902, 15351.385944562317, 15354.155521446204, 15430.691386172213, 15517.37930482768, 9904.504774761233, 9971.0, 11995.280283183038, 12582.81125783114, 12588.81116783249, 14277.857221427861, 14280.42878284857, 14292.499762508261, 14298.142111473346, 14302.785458218135, 5729.684867332337, 5896.233489646404, 5903.166480089495, 5945.554083443759, 5970.940290597038, 1015.3400289811682, 1040.2718097331897, 1041.2398948767443, 1044.9634262800766, 1062.3041907550567, 23403.76596234016, 23756.524869502515, 23781.0, 23798.405039874142, 23805.28584142444, 1130.4291332876844, 1132.4507613807298, 1138.6185627814775, 1140.5380820767602, 1196.5572738086964, 12754.61736147917, 12802.487900484062, 12805.359732013361, 12806.015067664526, 12817.102802803714, 316403.0, 319264.0, 320841.0, 320874.0, 320987.0, 54744.72627636916, 55608.0, 55694.16458753122, 55694.16458753122, 55745.0, 1440.107133577189, 1446.5443385333376, 1475.2992328644023, 1491.3885307024068, 1498.5504348695347, 23814.0, 24833.751662483868, 25257.74742252554, 25282.620760688238, 25352.366190845376, 39472.21055578815, 39559.80220098881, 39565.2086958265, 39621.80189099036, 39654.603453965094, 280853.0, 281007.0, 283001.0, 283276.0, 284218.0, 25205.747942521073, 25542.23373298804, 30220.395592088476, 30783.84608077035, 33456.1635959103, 35882.282354352246, 39639.0, 39673.60326396814, 39892.20215595614, 40904.386434204105, 29776.70223297826, 30330.696693032787, 30369.98332960133, 30518.694813051585, 30528.236794080327, 30496.847515762278, 30575.0, 30727.078187654406, 31037.534436983013, 31621.0, 34827.82586087054, 35018.29963400667, 35321.823390882884, 35811.0, 36049.0, 28967.855160724062, 29131.563026555043, 29176.27059323534, 29395.55906661359, 29611.407771844013, 23132.421689457897, 24141.0, 24682.50634987326, 24714.534161490683, 24948.12681556137], "value": 17124.526438755023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.92843752343333, 412.58329087621496, 423.67377119617896, 432.9740215587065, 433.96094351508367, 21057.262995795132, 21751.99999999998, 21762.129514819408, 22171.889140554315, 22179.1128354866, 22586.54826903461, 22757.658635120446, 22942.0, 22962.88518557409, 23279.185228517006, 5815.970920145404, 6084.300305464884, 6090.48230900374, 6103.511719062464, 6106.023036314191, 5690.231818704463, 5910.586258961875, 5934.31755348134, 5943.108533719934, 5944.346121926585, 5777.133429985493, 5889.381614930435, 5901.734421951022, 5908.1433192187105, 5917.289925208981, 5802.071668533035, 5909.084091965752, 5910.172575839386, 5914.319853216892, 5915.497182739472, 5235.240890070919, 5291.312129423189, 5311.787528498855, 5333.706646134461, 5338.786448542053, 25509.0, 25540.36149096269, 25622.23133305985, 25676.0, 25750.227493175236, 1992.7309813175325, 1995.092233033966, 1995.3515107589947, 2012.255465477768, 2026.9561175994374, 15526.61183470411, 16531.91734041334, 16656.75014874778, 16762.916185419115, 17055.232514536874, 1739.2868923741332, 1741.8693597980202, 1745.1099939031058, 1775.0680892531395, 1806.7922188948307, 98608.0, 100830.0, 101149.0, 102193.48903255437, 102660.0, 11619.593314233962, 11698.47356868943, 11722.58970936013, 11843.28940263587, 11968.067823383153, 16649.16754162287, 16661.0, 16687.165641717864, 16702.24839882208, 16758.497245082668, 8425.915740842636, 8441.831163376699, 8573.0, 8732.0, 8797.868031979526, 8087.878681819778, 8094.595270236465, 8294.668213271401, 8298.626561804733, 8299.0, 7600.745876930355, 7656.0859785053735, 7804.0, 7850.450468467267, 7885.290323870764, 2024.473636854399, 2062.257587268582, 2103.7054812326287, 2105.8315334773183, 2144.324537770597, 989.1789814453986, 1018.9759291911581, 1027.6968294353185, 1033.452270296744, 1059.3749687684303, 20207.797922020887, 20394.388168354973, 20604.0, 20694.21783596634, 20930.267440639505, 1044.4777611194402, 1046.1630695443614, 1058.9622170273021, 1069.2354966199205, 1071.721352448369, 10871.782564348669, 12302.692432689255, 13307.135036222615, 13502.797458038138, 13526.850217731602, 610358.0, 625205.7232559738, 639730.0, 673875.0, 681496.0, 108762.45618772013, 110626.0, 110829.0, 112975.0, 114187.0, 1203.8796120387892, 1224.5469176404788, 1262.6527704881232, 1268.2834198677717, 1270.3203785974458, 19650.90174549118, 20817.0, 20879.373618791462, 20903.268385606432, 21077.473063173544, 49804.0, 50738.49261507337, 50863.0, 53125.0, 53729.0, 65316.02025969519, 65360.0, 65892.34107658862, 67359.66320168368, 67405.0, 8750.81229692577, 8913.28693704515, 8926.419782714103, 9073.183413492818, 9149.496777677025, 13689.0, 13834.93082534581, 14476.710465790415, 15440.691186175989, 15669.216539172769, 12485.250884946932, 12492.25046497213, 12680.556180533637, 12853.42159602839, 13068.607941761762, 11323.377214253294, 11382.203245773047, 12006.879931200576, 12186.0, 12210.450529726362, 12583.119181657195, 12821.615351539469, 12834.0, 12883.613491595268, 13195.868041319463, 8836.602352894006, 12559.748805024032, 12684.936575317064, 13636.727265454834, 13656.590302290948, 6521.250056243593, 12101.878981210075, 12471.688207794878, 12604.684882878002, 12930.935345323212], "value": 10307.520666281647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1166.7199872030706, 1308.2412200923466, 1367.3095086981073, 1389.583125062481, 1389.99305003475, 8977.955110224448, 10798.352098874073, 10972.177086718488, 11054.778904421906, 11057.391843448608, 10683.358998460099, 10771.730706732336, 10779.245452818306, 10782.946085269563, 10783.0, 2006.2677122850127, 2230.654248591463, 2270.909163633453, 2274.9886250568725, 2275.601769690306, 2096.454921720356, 2368.632861906399, 2422.8667423291713, 2452.705675318964, 2453.668754718108, 2390.497995420964, 2391.545606334791, 2397.5324811661735, 2397.988010059947, 2401.4596715738994, 2304.2511183865313, 2332.8017118544944, 2343.95312093758, 2344.34358379654, 2365.3613524348416, 2358.858468491896, 2401.447667036591, 2406.6991626046743, 2414.541237164933, 2415.347856078849, 10557.41934193619, 10710.839337409945, 10720.571177152904, 10725.249232553646, 10728.195385346053, 6393.680315984182, 6627.337266273383, 6628.038934354539, 6629.204495460527, 6635.601863888182, 3497.6852083312624, 3548.183917698944, 3773.848906123511, 3800.467934489174, 3803.9239215215816, 1300.505807793042, 1335.2255691698792, 1340.7184491256849, 1385.4804448331874, 1397.2594524901817, 15618.219089045502, 15688.92155539215, 15696.0, 15705.921470392803, 15716.764248536281, 5435.510804027656, 5662.348829884616, 5710.514606258432, 5773.134029895549, 5831.650100993869, 13723.1079979801, 13896.58310250694, 13919.443222271198, 13921.930390347983, 13922.791158132635, 6190.102435146879, 6413.134226879311, 6445.613263204223, 6447.194100737408, 6467.450266727286, 4861.440934292602, 4997.85006449807, 5795.9420405796245, 5801.6519008859605, 5805.564582656318, 3974.82113304902, 4325.783710814447, 4375.0, 4449.1101779644205, 4463.285874260103, 1351.3175846197607, 1384.6815232496583, 1391.3669280477359, 1401.0402874031322, 1413.4487549855564, 831.4387788243033, 854.3592305770673, 860.8751730999095, 879.4767113567417, 879.612970293069, 6182.28903676083, 6267.968660156761, 6468.68480646968, 6491.383318584727, 6509.1863517060365, 922.4741897118712, 952.4523399045577, 953.5041778275258, 953.8521529162991, 963.710886733977, 4293.828246870153, 4501.122281155143, 4521.954780452219, 4595.655325850575, 4647.140279048387, 14235.43058277678, 14651.633709157357, 14658.19379934114, 14659.706805863823, 14704.044237124766, 14126.152430853976, 14763.77854332186, 14767.26163691811, 14771.0, 14780.113193208443, 10544.209184311207, 10553.102986246102, 10586.523606437575, 10609.310394824312, 10713.625023124154, 6561.573497722633, 6728.05807187004, 6754.5609535380045, 6766.729330826712, 6778.32216778338, 12680.112392132462, 12803.10378273512, 13119.540816071392, 13144.0, 13177.077604567972, 12704.491820327083, 13262.204267743966, 13263.734725305247, 13454.52909148175, 13509.568277709714, 8894.86657700148, 9022.684206052756, 9107.08929107084, 9112.95443522778, 9113.453192808453, 9711.077447642463, 9714.3199976001, 9717.319787614799, 9774.902250977399, 9822.214222862296, 8496.617652205789, 8611.224989750952, 8631.654733810828, 8703.695370661997, 8893.510856902933, 8617.095205003385, 8664.176903194439, 8700.56497175126, 8759.956200218958, 8950.060243674321, 7725.652345644347, 7727.0, 7742.690292388242, 7751.6511756972195, 7774.067111946377, 5863.589548731547, 5911.881762364815, 5970.104484327386, 6042.214512113573, 6183.752649893954, 6015.939840601538, 6072.423119803611, 6161.322254551906, 6192.535559832941, 6315.747410064096], "value": 5292.565902351741, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.76590981771653, 384.9384098544232, 388.0879932159424, 405.9086705491265, 411.78998710657567, 5747.913781293284, 5931.703414829258, 5973.4623883850445, 5992.531829701724, 5997.130416089664, 5772.5670574706955, 5817.709114544266, 5830.09633506806, 5830.7084645767645, 5835.124731290298, 4490.820367185309, 4496.415465989417, 4506.053728716974, 4508.97745511272, 4519.977400113011, 4301.139772045603, 4465.598096171344, 4474.507804141542, 4513.480949690778, 4516.074204788027, 4430.446194225722, 4434.645228381722, 4435.667324950641, 4441.62246209071, 4442.533533978934, 4433.157700036999, 4440.26829536481, 4455.376247325377, 4455.777211139462, 4487.798049087799, 3713.16453797896, 3815.561210460805, 3939.98030009851, 3941.1526521797664, 3958.366661334173, 5673.220122140163, 5682.204491371212, 5705.657660540381, 5709.743061562198, 5719.0, 5144.254083157958, 5156.097682905476, 5166.483351664803, 5168.457311982263, 5183.092958732207, 6045.23482723639, 6045.244344456943, 6074.726637301332, 6167.599106058092, 6178.949578571654, 4314.158739045856, 4314.892127696801, 4328.900483265646, 4334.089841133366, 4337.327714204272, 6160.969195154041, 6222.81331560054, 6324.810255692382, 6479.1901012373455, 6560.376764207393, 4396.890077748082, 4424.823007079745, 4425.114977004548, 4437.600615944581, 4442.8004438801345, 4468.977655111704, 4497.0, 4512.435945506812, 4519.141363140992, 4521.5930566248535, 5010.473900240495, 5134.0, 5174.120399532088, 5194.714290714047, 5214.243934629458, 6231.532635052389, 6236.345183755731, 6245.125682404467, 6253.343398943137, 6260.968695156495, 1531.6783475470054, 1558.2754019381043, 1559.7288210108725, 1563.3121426572272, 1580.6364536156748, 1007.4811472091878, 1047.7694907120422, 1055.0, 1056.0917610854658, 1063.6011495689118, 5985.610935289279, 6001.099835024781, 6004.819855404345, 6031.2159419276095, 6033.245844269466, 6203.689815509207, 6373.330800265998, 6374.872502550016, 6427.807165785034, 6429.7749578764515, 5971.20863740876, 5972.731227094791, 6022.5483088768515, 6047.909281360783, 6055.969720151459, 3304.7521435892404, 3357.2949680567353, 3388.4409072503254, 3397.7451691123265, 3399.6600339965808, 6369.076483909807, 6701.1623547056615, 6737.52837301394, 6748.156480439945, 6805.795826125224, 6524.347565243438, 6567.868642627216, 6572.737090516326, 6582.835429114215, 6587.440067594212, 6398.584092034003, 6678.465722742072, 6678.49911256648, 6770.69531871067, 6805.3875151236625, 6382.393672601095, 6385.786700526885, 6391.904121438275, 6398.48812095022, 6441.0, 6130.233720784902, 6276.121343012073, 6328.0, 6359.109724638647, 6402.93597064042, 6662.100616416722, 6667.533272670867, 6673.431743540361, 6712.496562757715, 6749.502684006752, 4440.777961101997, 4446.666500012448, 4452.688311818141, 4470.061287129739, 4474.709143905636, 6006.9576344043235, 6347.301796802256, 6399.816034033719, 6453.903191452038, 6463.3213512580505, 6237.719302631302, 6239.594426362272, 6242.563020588515, 6242.7514497099855, 6259.7167580646765, 6151.477124444473, 6224.688765561795, 6231.881160405484, 6242.5942313749465, 6271.3728627136925, 6175.197224360804, 6188.535859810442, 6192.690365481798, 6216.725571257791, 6219.253689557282, 6092.634441933498, 6231.2522497298805, 6247.406496382836, 6281.560290779785, 6287.182666253358, 6071.089336599545, 6085.817425477243, 6095.847603809762, 6097.420745029215, 6115.847103822262], "value": 4709.554098791637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2643861892583, 771.9228077192281, 776.5146783260462, 782.4131901074194, 788.5702292250725, 14767.556973290792, 14793.704125917475, 14885.92557037216, 14944.327505262263, 14973.700525989474, 14917.254137293146, 14929.7014059719, 15064.246787660628, 15083.245837708098, 15095.169765662884, 813.9145389734082, 841.3017195727562, 842.4061036968952, 844.7339088187232, 845.1252953193446, 837.7109897085496, 843.3464065349373, 845.0366582096415, 845.5687599324358, 846.2764336492303, 873.2751815992742, 877.7103555826562, 878.8505953987806, 878.8549889268263, 880.3353468131584, 868.7480630617114, 869.0223498564116, 880.7049638371153, 885.2165833237567, 885.8804061451686, 643.8165122939939, 644.4876323322969, 645.4320198225531, 645.9644719540423, 646.5894157210158, 16531.752023719655, 16998.00546871484, 17058.573535661584, 17086.829131708648, 17530.0, 15179.392824287015, 15281.923590381977, 15296.158711270988, 15440.922795385952, 16074.517764467084, 12393.442295096742, 12626.494940202381, 12633.11568190227, 12673.746525069539, 12709.936450317782, 3207.903762887117, 3260.315333779909, 3321.186309354224, 3342.147752323142, 3386.3058073095203, 86995.56502217511, 87121.56439217764, 88315.0, 90374.0, 90776.0, 11761.0, 11883.227590206609, 12151.331676757864, 12175.634730958085, 12186.0, 22140.55718885613, 24377.756222437903, 24398.146064888, 24597.754022459903, 24664.260072197863, 7866.646000929972, 8023.879641805378, 8122.431429799975, 8151.307138893142, 8196.590170491452, 3994.862614611802, 4017.276890159741, 4074.2258970795456, 4078.6737061035046, 4159.376093585986, 4225.556316586775, 4235.0, 4241.236577416094, 4276.123394704078, 4299.032717638569, 823.9011318641801, 826.5949684654596, 835.2107258640648, 838.9706360277484, 850.9702160424356, 640.9583377080475, 646.4602057282128, 653.0922018394435, 660.6102399584269, 676.4993904510725, 10366.637167699095, 10974.835377469344, 11118.277311974696, 11121.332720036824, 11271.492782824793, 627.1282916745727, 645.95155363347, 652.1945397434165, 652.7323797243107, 657.7960832142052, 4599.264117741145, 4932.8766780830765, 4935.111679897653, 4950.356453661001, 4951.603871690256, 77379.61310193413, 77462.6126869362, 78308.60845695736, 79493.0, 80736.59631701803, 69023.30976690169, 69525.65237173781, 70483.0, 71297.64351178211, 73953.6302318485, 61746.69126654338, 61890.38109618936, 62081.0, 62230.0, 63902.041469378, 9477.857832132386, 9693.0, 9718.611255549982, 9748.0, 9777.951110244403, 32955.8352208247, 33143.50284745779, 33186.33627327488, 33688.49467257944, 34479.655203448645, 40096.39855402229, 40562.39156412715, 40696.38955415612, 50511.49488505068, 51052.10796542419, 13351.79972300397, 14320.283985800459, 14352.0, 14448.27758612044, 14799.482018129744, 14057.22685252321, 15308.617284567976, 15862.603434913757, 16256.43102491407, 16820.831791681925, 14445.422183112558, 15306.08163510193, 15366.769498457308, 15620.0, 15848.44530441429, 13582.388792504558, 14506.85493145055, 14582.125072495684, 14926.179060151795, 15159.166245856142, 13361.064725469123, 14027.719445611236, 14186.503472378417, 14553.19957402353, 14612.488562900247, 10686.305390149615, 10971.177161712743, 11127.054200393057, 11185.66443006711, 11243.55025798959, 11165.0, 11395.430228488709, 12266.07189975254, 12468.127231093737, 12626.936865315614], "value": 7418.59155774103, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 108.0, 110.0, 108.0, 110.0, 109.0, 108.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 118.0, 157.0, 118.0, 124.0, 117.0, 122.0, 141.0, 124.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 164.0, 163.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 109.0, 76.0, 74.0, 74.0, 74.0, 101.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 110.0, 82.0, 83.0, 83.0, 101.0, 84.0, 83.0, 101.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 56.0, 58.0, 57.0, 58.0, 57.0, 57.0, 59.0, 57.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 133.0, 128.0, 131.0, 124.0, 136.0, 132.0, 133.0, 175.0, 131.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 191.0, 182.0, 184.0, 181.0, 181.0, 180.0, 177.0, 184.0, 187.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0], "value": 65.6, "unit": "score"}]}]} 07:39:37 INFO - Return code: 0 07:39:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:37 ERROR - # TBPL SUCCESS # 07:39:37 INFO - Running post-action listener: _resource_record_post_action 07:39:37 INFO - [mozharness: 2017-03-24 14:39:37.526947Z] Finished run-tests step (success) 07:39:37 INFO - Running post-run listener: _resource_record_post_run 07:39:37 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 2490368; Write bytes: 371585024; Read time: 1452; Write time: 211016 07:39:37 INFO - TinderboxPrint: CPU usage
12.9% 07:39:37 INFO - TinderboxPrint: I/O read bytes / time
2,490,368 / 1,452 07:39:37 INFO - TinderboxPrint: I/O write bytes / time
371,585,024 / 211,016 07:39:37 INFO - TinderboxPrint: CPU idle
8,311.5 (87.1%) 07:39:37 INFO - TinderboxPrint: CPU user
1,187.6 (12.4%) 07:39:37 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112402432; Read time: 0; Write time: 75176 07:39:37 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 2490368; Write bytes: 259182592; Read time: 1452; Write time: 135840 07:39:38 INFO - Running post-run listener: _upload_blobber_files 07:39:38 INFO - Blob upload gear active. 07:39:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:38 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:39 INFO - (blobuploader) - INFO - Done attempting. 07:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:40 INFO - (blobuploader) - INFO - Done attempting. 07:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:41 INFO - (blobuploader) - INFO - Done attempting. 07:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:45 INFO - (blobuploader) - INFO - Done attempting. 07:39:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:45 INFO - Return code: 0 07:39:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10959c52b7f8cb0bd2b0e22e2963896a2a7be5538c05c3fa4499aeaba38110eb5fd43783f2c166d7d2ec6b204d089c68ac41de778faceb151911237ab2d0ece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4920948d8c07955537179a8d1122360f59769dbfe1fd0bf643d35cf84b588c775f64dec64de6d5358b0926c1ffb68eb2422033ed2dff0dd24fb90f5c8fc9956a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f96243c4dc12356386cd1e365a3a60f6c280bdf8913624ed7003f7f53ce73c08ec5c840e60fe6cee3d82f916f05bdf881472abc15daadd13ef1b8ab6f092d4f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0c7b4d8c8a6cd0eab41a089f5f3ef80f985468f13b803b3d97c2a8591a1ddc5a43a8444884f84ef567aba8030cb9ea8314149bfa186a69cba25f92cf2d5a790"} 07:39:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:45 INFO - Contents: 07:39:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10959c52b7f8cb0bd2b0e22e2963896a2a7be5538c05c3fa4499aeaba38110eb5fd43783f2c166d7d2ec6b204d089c68ac41de778faceb151911237ab2d0ece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4920948d8c07955537179a8d1122360f59769dbfe1fd0bf643d35cf84b588c775f64dec64de6d5358b0926c1ffb68eb2422033ed2dff0dd24fb90f5c8fc9956a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f96243c4dc12356386cd1e365a3a60f6c280bdf8913624ed7003f7f53ce73c08ec5c840e60fe6cee3d82f916f05bdf881472abc15daadd13ef1b8ab6f092d4f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0c7b4d8c8a6cd0eab41a089f5f3ef80f985468f13b803b3d97c2a8591a1ddc5a43a8444884f84ef567aba8030cb9ea8314149bfa186a69cba25f92cf2d5a790"} 07:39:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:45 INFO - Copying logs to upload dir... 07:39:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.750366 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-24 07:39:44.680041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:39:44.683992) ========= 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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10959c52b7f8cb0bd2b0e22e2963896a2a7be5538c05c3fa4499aeaba38110eb5fd43783f2c166d7d2ec6b204d089c68ac41de778faceb151911237ab2d0ece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4920948d8c07955537179a8d1122360f59769dbfe1fd0bf643d35cf84b588c775f64dec64de6d5358b0926c1ffb68eb2422033ed2dff0dd24fb90f5c8fc9956a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f96243c4dc12356386cd1e365a3a60f6c280bdf8913624ed7003f7f53ce73c08ec5c840e60fe6cee3d82f916f05bdf881472abc15daadd13ef1b8ab6f092d4f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0c7b4d8c8a6cd0eab41a089f5f3ef80f985468f13b803b3d97c2a8591a1ddc5a43a8444884f84ef567aba8030cb9ea8314149bfa186a69cba25f92cf2d5a790"} build_url:https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/cRpriiMFRlWsc_RYTC3c5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10959c52b7f8cb0bd2b0e22e2963896a2a7be5538c05c3fa4499aeaba38110eb5fd43783f2c166d7d2ec6b204d089c68ac41de778faceb151911237ab2d0ece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4920948d8c07955537179a8d1122360f59769dbfe1fd0bf643d35cf84b588c775f64dec64de6d5358b0926c1ffb68eb2422033ed2dff0dd24fb90f5c8fc9956a", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f96243c4dc12356386cd1e365a3a60f6c280bdf8913624ed7003f7f53ce73c08ec5c840e60fe6cee3d82f916f05bdf881472abc15daadd13ef1b8ab6f092d4f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0c7b4d8c8a6cd0eab41a089f5f3ef80f985468f13b803b3d97c2a8591a1ddc5a43a8444884f84ef567aba8030cb9ea8314149bfa186a69cba25f92cf2d5a790"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:39:44.709822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:39:44.710170) ========= 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-1490365128.822787-1677145202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:39:44.794669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:39:44.794991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:39:44.795397) ========= ========= Total master_lag: 0.17 =========