builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1489678930.18 results: success (0) revision: 468dde25160493591211fe0505dd2ccdd6c9a0bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.180166) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.180571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.180841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.195563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.195864) ========= 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=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-16 08:42:10-- 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% 88.7M=0s 2017-03-16 08:42:10 (88.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139868 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.391092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.391367) ========= 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=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019584 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.425554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:10.425856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 468dde25160493591211fe0505dd2ccdd6c9a0bb --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 468dde25160493591211fe0505dd2ccdd6c9a0bb --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=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-16 08:42:10,675 truncating revision to first 12 chars 2017-03-16 08:42:10,675 Setting DEBUG logging. 2017-03-16 08:42:10,675 attempt 1/10 2017-03-16 08:42:10,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/468dde251604?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 08:42:10,960 unpacking tar archive at: mozilla-central-468dde251604/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605140 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:11.044923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:11.045992) ========= script_repo_revision: 468dde25160493591211fe0505dd2ccdd6c9a0bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:11.046484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:11.046807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 08:42:11.057636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-16 08:42:11.058069) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:11 INFO - MultiFileLogger online at 20170316 08:42:11 in /builds/slave/test 08:42:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:42:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:11 INFO - {'append_to_log': False, 08:42:11 INFO - 'base_work_dir': '/builds/slave/test', 08:42:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:42:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:11 INFO - 'branch': 'Firefox-Non-PGO', 08:42:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:11 INFO - 'config_files': ('talos/linux_config.py',), 08:42:11 INFO - 'default_actions': ('clobber', 08:42:11 INFO - 'read-buildbot-config', 08:42:11 INFO - 'download-and-extract', 08:42:11 INFO - 'populate-webroot', 08:42:11 INFO - 'create-virtualenv', 08:42:11 INFO - 'install', 08:42:11 INFO - 'run-tests'), 08:42:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:11 INFO - 'download_minidump_stackwalk': True, 08:42:11 INFO - 'download_symbols': 'ondemand', 08:42:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:11 INFO - 'gecko_profile': False, 08:42:11 INFO - 'gecko_profile_interval': 0, 08:42:11 INFO - 'installer_path': 'installer.exe', 08:42:11 INFO - 'log_level': 'info', 08:42:11 INFO - 'log_name': 'talos', 08:42:11 INFO - 'log_to_console': True, 08:42:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:11 INFO - 'opt_config_files': (), 08:42:11 INFO - 'pip_index': False, 08:42:11 INFO - 'suite': 'dromaeojs-e10s', 08:42:11 INFO - 'system_bits': '32', 08:42:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:11 INFO - 'title': 'talos-linux64-ix-017', 08:42:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:11 INFO - 'use_talos_json': True, 08:42:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:11 INFO - 'work_dir': 'build'} 08:42:11 INFO - [mozharness: 2017-03-16 15:42:11.410541Z] Running clobber step. 08:42:11 INFO - Running pre-action listener: _resource_record_pre_action 08:42:11 INFO - Running main action method: clobber 08:42:11 INFO - rmtree: /builds/slave/test/build 08:42:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:12 INFO - Running post-action listener: _resource_record_post_action 08:42:12 INFO - [mozharness: 2017-03-16 15:42:12.344484Z] Finished clobber step (success) 08:42:12 INFO - [mozharness: 2017-03-16 15:42:12.344583Z] Running read-buildbot-config step. 08:42:12 INFO - Running pre-action listener: _resource_record_pre_action 08:42:12 INFO - Running main action method: read_buildbot_config 08:42:12 INFO - Using buildbot properties: 08:42:12 INFO - { 08:42:12 INFO - "project": "", 08:42:12 INFO - "product": "firefox", 08:42:12 INFO - "who": "cbook@mozilla.com", 08:42:12 INFO - "installer_path": "public/build/target.tar.bz2", 08:42:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:42:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:42:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:42:12 INFO - "stage_platform": "linux64", 08:42:12 INFO - "basedir": "/builds/slave/test", 08:42:12 INFO - "buildnumber": 468, 08:42:12 INFO - "platform": "ubuntu64_hw", 08:42:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:12 INFO - "slavebuilddir": "test", 08:42:12 INFO - "taskId": "awN8PVlmRnuW_V4W9qAQYw", 08:42:12 INFO - "branch": "mozilla-central", 08:42:12 INFO - "script_repo_revision": "production", 08:42:12 INFO - "revision": "468dde25160493591211fe0505dd2ccdd6c9a0bb", 08:42:12 INFO - "slavename": "talos-linux64-ix-017", 08:42:12 INFO - "repo_path": "mozilla-central" 08:42:12 INFO - } 08:42:12 INFO - Finding installer, test and symbols from parent task. 08:42:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awN8PVlmRnuW_V4W9qAQYw'}, attempt #1 08:42:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awN8PVlmRnuW_V4W9qAQYw'}, attempt #1 08:42:13 INFO - Task dependencies: DwPl77w9S7W-tjgoe1S4JQ 08:42:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ'}, attempt #1 08:42:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 08:42:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/test_packages.json 08:42:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.crashreporter-symbols.zip 08:42:13 INFO - Running post-action listener: _resource_record_post_action 08:42:13 INFO - [mozharness: 2017-03-16 15:42:13.747389Z] Finished read-buildbot-config step (success) 08:42:13 INFO - [mozharness: 2017-03-16 15:42:13.747634Z] Running download-and-extract step. 08:42:13 INFO - Running pre-action listener: _resource_record_pre_action 08:42:13 INFO - Running main action method: download_and_extract 08:42:13 INFO - mkdir: /builds/slave/test/build/tests 08:42:13 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')]} 08:42:13 INFO - trying https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.test_packages.json 08:42:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:42:14 INFO - Downloaded 986 bytes. 08:42:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:42:14 INFO - Using the following test package requirements: 08:42:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:42:14 INFO - u'common': [u'target.common.tests.zip'], 08:42:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:42:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:42:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:42:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:42:14 INFO - u'mozbase': [u'target.common.tests.zip'], 08:42:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:42:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:42:14 INFO - u'web-platform': [u'target.common.tests.zip', 08:42:14 INFO - u'target.web-platform.tests.zip'], 08:42:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:42:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip 08:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:14 INFO - Fetch https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip into memory 08:42:15 INFO - Expected file size: 58186233 08:42:15 INFO - Obtained file size: 58186233 08:42:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:42:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip 08:42:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:42:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.common.tests.zip into memory 08:42:26 INFO - Expected file size: 58186233 08:42:26 INFO - Obtained file size: 58186233 08:42:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.talos.tests.zip 08:42:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:42:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.talos.tests.zip into memory 08:42:37 INFO - Expected file size: 14404452 08:42:37 INFO - Obtained file size: 14404452 08:42:37 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')]} 08:42:37 INFO - trying https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 08:42:37 INFO - Downloading https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:42:39 INFO - Downloaded 61674574 bytes. 08:42:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 08:42:39 INFO - mkdir: /builds/slave/test/properties 08:42:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:39 INFO - Contents: 08:42:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 08:42:39 INFO - Running post-action listener: _resource_record_post_action 08:42:39 INFO - Running post-action listener: set_extra_try_arguments 08:42:39 INFO - [mozharness: 2017-03-16 15:42:39.022090Z] Finished download-and-extract step (success) 08:42:39 INFO - [mozharness: 2017-03-16 15:42:39.022187Z] Running populate-webroot step. 08:42:39 INFO - Running pre-action listener: _resource_record_pre_action 08:42:39 INFO - Running main action method: populate_webroot 08:42:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:39 INFO - '--tppagecycles', 08:42:39 INFO - '7'], 08:42:39 INFO - 'tests': ['tsvgm']}}, 08:42:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['damp', 'tps']}, 08:42:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'tests': ['damp', 'tps']}, 08:42:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['dromaeo_dom']}, 08:42:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['basic_compositor_video']}, 08:42:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['a11yr', 08:42:39 INFO - 'ts_paint', 08:42:39 INFO - 'tpaint', 08:42:39 INFO - 'sessionrestore', 08:42:39 INFO - 'sessionrestore_no_auto_restore', 08:42:39 INFO - 'tabpaint']}, 08:42:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['tsvgx', 08:42:39 INFO - 'tsvgr_opacity', 08:42:39 INFO - 'tart', 08:42:39 INFO - 'tscrollx', 08:42:39 INFO - 'cart', 08:42:39 INFO - 'tsvg_static']}, 08:42:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:39 INFO - 'tsvgr_opacity', 08:42:39 INFO - 'tart', 08:42:39 INFO - 'tscrollx', 08:42:39 INFO - 'cart', 08:42:39 INFO - 'tsvg_static']}, 08:42:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'talos_options': ['--disable-e10s'], 08:42:39 INFO - 'tests': ['tp5o']}, 08:42:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'talos_options': ['--disable-e10s', 08:42:39 INFO - '--xperf_path', 08:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:39 INFO - 'tests': ['tp5n']}, 08:42:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:39 INFO - 'talos_options': ['--xperf_path', 08:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:39 INFO - 'tests': ['tp5n']}}, 08:42:39 INFO - 'talos.zip': {'path': '', 08:42:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:39 INFO - Running post-action listener: _resource_record_post_action 08:42:39 INFO - [mozharness: 2017-03-16 15:42:39.035377Z] Finished populate-webroot step (success) 08:42:39 INFO - [mozharness: 2017-03-16 15:42:39.035466Z] Running create-virtualenv step. 08:42:39 INFO - Running pre-action listener: _resource_record_pre_action 08:42:39 INFO - Running main action method: create_virtualenv 08:42:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:39 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 08:42:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:39 INFO - Using real prefix '/usr' 08:42:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:41 INFO - Installing pip.................done. 08:42:41 INFO - Return code: 0 08:42:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:41 INFO - Reading from file tmpfile_stdout 08:42:41 INFO - Output received: 08:42:41 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) 08:42:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42: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', 'pip>=1.5'] in /builds/slave/test/build 08:42: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 pip>=1.5 08:42:41 INFO - Using env: {'DISPLAY': ':0', 08:42:41 INFO - 'HOME': '/home/cltbld', 08:42:41 INFO - 'LANG': 'en_US.UTF-8', 08:42:41 INFO - 'LANGUAGE': 'en_US:en', 08:42:41 INFO - 'LOGNAME': 'cltbld', 08:42:41 INFO - 'MAIL': '/var/mail/cltbld', 08:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:41 INFO - 'MOZ_NO_REMOTE': '1', 08:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:41 INFO - 'NO_EM_RESTART': '1', 08:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:41 INFO - 'PWD': '/builds/slave/test', 08:42:41 INFO - 'SHELL': '/bin/bash', 08:42:41 INFO - 'SHLVL': '1', 08:42:41 INFO - 'TERM': 'linux', 08:42:41 INFO - 'TMOUT': '86400', 08:42:41 INFO - 'USER': 'cltbld', 08:42:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:41 INFO - '_': '/tools/buildbot/bin/python'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 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 08:42:42 INFO - Cleaning up... 08:42:42 INFO - Return code: 0 08:42:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:42 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')]} 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 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')]} 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:42 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 08:42:42 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 08:42:42 INFO - Using env: {'DISPLAY': ':0', 08:42:42 INFO - 'HOME': '/home/cltbld', 08:42:42 INFO - 'LANG': 'en_US.UTF-8', 08:42:42 INFO - 'LANGUAGE': 'en_US:en', 08:42:42 INFO - 'LOGNAME': 'cltbld', 08:42:42 INFO - 'MAIL': '/var/mail/cltbld', 08:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:42 INFO - 'MOZ_NO_REMOTE': '1', 08:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:42 INFO - 'NO_EM_RESTART': '1', 08:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:42 INFO - 'PWD': '/builds/slave/test', 08:42:42 INFO - 'SHELL': '/bin/bash', 08:42:42 INFO - 'SHLVL': '1', 08:42:42 INFO - 'TERM': 'linux', 08:42:42 INFO - 'TMOUT': '86400', 08:42:42 INFO - 'USER': 'cltbld', 08:42:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:42 INFO - '_': '/tools/buildbot/bin/python'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Downloading/unpacking psutil>=3.1.1 08:42:42 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 08:42:42 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 08:42:42 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 08:42:42 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 08:42:42 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 08:42:42 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 08:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:44 INFO - Installing collected packages: psutil 08:42:44 INFO - Running setup.py install for psutil 08:42:44 INFO - building 'psutil._psutil_linux' extension 08:42:44 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 08:42:44 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 08:42:44 INFO - building 'psutil._psutil_posix' extension 08:42:44 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 08:42:44 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 08:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:44 INFO - Successfully installed psutil 08:42:44 INFO - Cleaning up... 08:42:44 INFO - Return code: 0 08:42:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:44 INFO - Using env: {'DISPLAY': ':0', 08:42:44 INFO - 'HOME': '/home/cltbld', 08:42:44 INFO - 'LANG': 'en_US.UTF-8', 08:42:44 INFO - 'LANGUAGE': 'en_US:en', 08:42:44 INFO - 'LOGNAME': 'cltbld', 08:42:44 INFO - 'MAIL': '/var/mail/cltbld', 08:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:44 INFO - 'MOZ_NO_REMOTE': '1', 08:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:44 INFO - 'NO_EM_RESTART': '1', 08:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:44 INFO - 'PWD': '/builds/slave/test', 08:42:44 INFO - 'SHELL': '/bin/bash', 08:42:44 INFO - 'SHLVL': '1', 08:42:44 INFO - 'TERM': 'linux', 08:42:44 INFO - 'TMOUT': '86400', 08:42:44 INFO - 'USER': 'cltbld', 08:42:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:44 INFO - '_': '/tools/buildbot/bin/python'} 08:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:45 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 08:42:45 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 08:42:45 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 08:42:45 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 08:42:45 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 08:42:45 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 08:42:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:47 INFO - Installing collected packages: mozsystemmonitor 08:42:47 INFO - Running setup.py install for mozsystemmonitor 08:42:47 INFO - Successfully installed mozsystemmonitor 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:47 INFO - Using env: {'DISPLAY': ':0', 08:42:47 INFO - 'HOME': '/home/cltbld', 08:42:47 INFO - 'LANG': 'en_US.UTF-8', 08:42:47 INFO - 'LANGUAGE': 'en_US:en', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MAIL': '/var/mail/cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SHLVL': '1', 08:42:47 INFO - 'TERM': 'linux', 08:42:47 INFO - 'TMOUT': '86400', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - '_': '/tools/buildbot/bin/python'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:49 INFO - warning: no files found matching '*.txt' 08:42:49 INFO - no previously-included directories found matching 'build' 08:42:49 INFO - no previously-included directories found matching 'dist' 08:42:49 INFO - no previously-included directories found matching '.git*' 08:42:49 INFO - Installing collected packages: jsonschema, functools32 08:42:49 INFO - Running setup.py install for functools32 08:42:50 INFO - warning: no files found matching '*.txt' 08:42:50 INFO - no previously-included directories found matching 'build' 08:42:50 INFO - no previously-included directories found matching 'dist' 08:42:50 INFO - no previously-included directories found matching '.git*' 08:42:50 INFO - Successfully installed jsonschema functools32 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:50 INFO - Using env: {'DISPLAY': ':0', 08:42:50 INFO - 'HOME': '/home/cltbld', 08:42:50 INFO - 'LANG': 'en_US.UTF-8', 08:42:50 INFO - 'LANGUAGE': 'en_US:en', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MAIL': '/var/mail/cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SHLVL': '1', 08:42:50 INFO - 'TERM': 'linux', 08:42:50 INFO - 'TMOUT': '86400', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - '_': '/tools/buildbot/bin/python'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:50 INFO - Using env: {'DISPLAY': ':0', 08:42:50 INFO - 'HOME': '/home/cltbld', 08:42:50 INFO - 'LANG': 'en_US.UTF-8', 08:42:50 INFO - 'LANGUAGE': 'en_US:en', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MAIL': '/var/mail/cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SHLVL': '1', 08:42:50 INFO - 'TERM': 'linux', 08:42:50 INFO - 'TMOUT': '86400', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - '_': '/tools/buildbot/bin/python'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:52 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 08:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:53 INFO - Downloading docopt-0.6.1.tar.gz 08:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:53 INFO - Running setup.py install for blobuploader 08:42:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:53 INFO - Running setup.py install for requests 08:42:53 INFO - Running setup.py install for docopt 08:42:53 INFO - Successfully installed blobuploader requests docopt 08:42:53 INFO - Cleaning up... 08:42:54 INFO - Return code: 0 08:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:54 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')]} 08:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:54 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')]} 08:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:54 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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:54 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 08:42:54 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 08:42:54 INFO - Using env: {'DISPLAY': ':0', 08:42:54 INFO - 'HOME': '/home/cltbld', 08:42:54 INFO - 'LANG': 'en_US.UTF-8', 08:42:54 INFO - 'LANGUAGE': 'en_US:en', 08:42:54 INFO - 'LOGNAME': 'cltbld', 08:42:54 INFO - 'MAIL': '/var/mail/cltbld', 08:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:54 INFO - 'MOZ_NO_REMOTE': '1', 08:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:54 INFO - 'NO_EM_RESTART': '1', 08:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:54 INFO - 'PWD': '/builds/slave/test', 08:42:54 INFO - 'SHELL': '/bin/bash', 08:42:54 INFO - 'SHLVL': '1', 08:42:54 INFO - 'TERM': 'linux', 08:42:54 INFO - 'TMOUT': '86400', 08:42:54 INFO - 'USER': 'cltbld', 08:42:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:54 INFO - '_': '/tools/buildbot/bin/python'} 08:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:54 INFO - Running setup.py (path:/tmp/pip-KbWBlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:54 INFO - Running setup.py (path:/tmp/pip-yNiaaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:54 INFO - Running setup.py (path:/tmp/pip-bJ7tLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:54 INFO - Running setup.py (path:/tmp/pip-ezk0BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:54 INFO - Running setup.py (path:/tmp/pip-9fjflN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:54 INFO - Running setup.py (path:/tmp/pip-DS8D34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:54 INFO - Running setup.py (path:/tmp/pip-BYmhTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:54 INFO - Running setup.py (path:/tmp/pip-Sp2Rft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:54 INFO - Running setup.py (path:/tmp/pip-soSM6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:54 INFO - Running setup.py (path:/tmp/pip-KnRNzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:54 INFO - Running setup.py (path:/tmp/pip-S6sZYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:55 INFO - Running setup.py (path:/tmp/pip-M0PrTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:55 INFO - Running setup.py (path:/tmp/pip-nYjdrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:55 INFO - Running setup.py (path:/tmp/pip-DPq3gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:55 INFO - Running setup.py (path:/tmp/pip-apCDVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:55 INFO - Running setup.py (path:/tmp/pip-QYhDzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:55 INFO - Running setup.py (path:/tmp/pip-mJsRrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:55 INFO - Running setup.py install for manifestparser 08:42:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for mozcrash 08:42:55 INFO - Running setup.py install for mozdebug 08:42:55 INFO - Running setup.py install for mozdevice 08:42:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:55 INFO - Running setup.py install for mozfile 08:42:56 INFO - Running setup.py install for mozhttpd 08:42:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozinfo 08:42:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozInstall 08:42:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozleak 08:42:56 INFO - Running setup.py install for mozlog 08:42:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for moznetwork 08:42:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozprocess 08:42:56 INFO - Running setup.py install for mozprofile 08:42:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozrunner 08:42:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:56 INFO - Running setup.py install for mozscreenshot 08:42:57 INFO - Running setup.py install for moztest 08:42:57 INFO - Running setup.py install for mozversion 08:42:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:57 INFO - Cleaning up... 08:42:57 INFO - Return code: 0 08:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:42:57 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 08:42:57 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 08:42:57 INFO - Using env: {'DISPLAY': ':0', 08:42:57 INFO - 'HOME': '/home/cltbld', 08:42:57 INFO - 'LANG': 'en_US.UTF-8', 08:42:57 INFO - 'LANGUAGE': 'en_US:en', 08:42:57 INFO - 'LOGNAME': 'cltbld', 08:42:57 INFO - 'MAIL': '/var/mail/cltbld', 08:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:57 INFO - 'MOZ_NO_REMOTE': '1', 08:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:57 INFO - 'NO_EM_RESTART': '1', 08:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:57 INFO - 'PWD': '/builds/slave/test', 08:42:57 INFO - 'SHELL': '/bin/bash', 08:42:57 INFO - 'SHLVL': '1', 08:42:57 INFO - 'TERM': 'linux', 08:42:57 INFO - 'TMOUT': '86400', 08:42:57 INFO - 'USER': 'cltbld', 08:42:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:57 INFO - '_': '/tools/buildbot/bin/python'} 08:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:57 INFO - Running setup.py (path:/tmp/pip-sgp9EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:57 INFO - Running setup.py (path:/tmp/pip-HLM9W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:57 INFO - Running setup.py (path:/tmp/pip-FsbCeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:57 INFO - Running setup.py (path:/tmp/pip-2hTf2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:57 INFO - Running setup.py (path:/tmp/pip-dmgl2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:57 INFO - Running setup.py (path:/tmp/pip-w9GZnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:57 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)) 08:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:57 INFO - Running setup.py (path:/tmp/pip-dyHqdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:58 INFO - Running setup.py (path:/tmp/pip-zh5tqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:58 INFO - Running setup.py (path:/tmp/pip-H62QCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:58 INFO - Running setup.py (path:/tmp/pip-OdMIll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:58 INFO - Running setup.py (path:/tmp/pip-CaGnjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:58 INFO - Running setup.py (path:/tmp/pip-xg94Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:58 INFO - Running setup.py (path:/tmp/pip-8YCcHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:58 INFO - Running setup.py (path:/tmp/pip-k0UTOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:58 INFO - Running setup.py (path:/tmp/pip-HZ8D2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:58 INFO - Running setup.py (path:/tmp/pip-4ySQZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:58 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)) 08:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:58 INFO - Running setup.py (path:/tmp/pip-qA_tse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:58 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)) 08:42:58 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)) 08:42:58 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)) 08:42:58 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)) 08:42:58 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)) 08:42:58 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)) 08:42:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:00 INFO - Downloading blessings-1.6.tar.gz 08:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:00 INFO - Installing collected packages: blessings 08:43:00 INFO - Running setup.py install for blessings 08:43:00 INFO - Successfully installed blessings 08:43:00 INFO - Cleaning up... 08:43:01 INFO - Return code: 0 08:43:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:01 INFO - Reading from file tmpfile_stdout 08:43:01 INFO - Current package versions: 08:43:01 INFO - argparse == 1.2.1 08:43:01 INFO - blessings == 1.6 08:43:01 INFO - blobuploader == 1.2.4 08:43:01 INFO - docopt == 0.6.1 08:43:01 INFO - functools32 == 3.2.3-2 08:43:01 INFO - jsonschema == 2.5.1 08:43:01 INFO - manifestparser == 1.1 08:43:01 INFO - mozInstall == 1.12 08:43:01 INFO - mozcrash == 1.0 08:43:01 INFO - mozdebug == 0.1 08:43:01 INFO - mozdevice == 0.49 08:43:01 INFO - mozfile == 1.2 08:43:01 INFO - mozhttpd == 0.7 08:43:01 INFO - mozinfo == 0.9 08:43:01 INFO - mozleak == 0.1 08:43:01 INFO - mozlog == 3.4 08:43:01 INFO - moznetwork == 0.27 08:43:01 INFO - mozprocess == 0.25 08:43:01 INFO - mozprofile == 0.28 08:43:01 INFO - mozrunner == 6.13 08:43:01 INFO - mozscreenshot == 0.1 08:43:01 INFO - mozsystemmonitor == 0.3 08:43:01 INFO - moztest == 0.8 08:43:01 INFO - mozversion == 1.4 08:43:01 INFO - psutil == 3.1.1 08:43:01 INFO - requests == 1.2.3 08:43:01 INFO - wsgiref == 0.1.2 08:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:01 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')]} 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:01 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')]} 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:01 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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:43:01 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 08:43:01 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 08:43:01 INFO - Using env: {'DISPLAY': ':0', 08:43:01 INFO - 'HOME': '/home/cltbld', 08:43:01 INFO - 'LANG': 'en_US.UTF-8', 08:43:01 INFO - 'LANGUAGE': 'en_US:en', 08:43:01 INFO - 'LOGNAME': 'cltbld', 08:43:01 INFO - 'MAIL': '/var/mail/cltbld', 08:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:01 INFO - 'MOZ_NO_REMOTE': '1', 08:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:01 INFO - 'NO_EM_RESTART': '1', 08:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:01 INFO - 'PWD': '/builds/slave/test', 08:43:01 INFO - 'SHELL': '/bin/bash', 08:43:01 INFO - 'SHLVL': '1', 08:43:01 INFO - 'TERM': 'linux', 08:43:01 INFO - 'TMOUT': '86400', 08:43:01 INFO - 'USER': 'cltbld', 08:43:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:01 INFO - '_': '/tools/buildbot/bin/python'} 08:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 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)) 08:43:01 INFO - Cleaning up... 08:43:01 INFO - Return code: 0 08:43:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:01 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')]} 08:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:01 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')]} 08:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:01 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 0x20061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a3b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, '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': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', '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 08:43:01 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 08:43:01 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 08:43:01 INFO - Using env: {'DISPLAY': ':0', 08:43:01 INFO - 'HOME': '/home/cltbld', 08:43:01 INFO - 'LANG': 'en_US.UTF-8', 08:43:01 INFO - 'LANGUAGE': 'en_US:en', 08:43:01 INFO - 'LOGNAME': 'cltbld', 08:43:01 INFO - 'MAIL': '/var/mail/cltbld', 08:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:01 INFO - 'MOZ_NO_REMOTE': '1', 08:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:01 INFO - 'NO_EM_RESTART': '1', 08:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:01 INFO - 'PWD': '/builds/slave/test', 08:43:01 INFO - 'SHELL': '/bin/bash', 08:43:01 INFO - 'SHLVL': '1', 08:43:01 INFO - 'TERM': 'linux', 08:43:01 INFO - 'TMOUT': '86400', 08:43:01 INFO - 'USER': 'cltbld', 08:43:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:01 INFO - '_': '/tools/buildbot/bin/python'} 08:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:01 INFO - Cleaning up... 08:43:01 INFO - Return code: 0 08:43:01 INFO - Running post-action listener: _resource_record_post_action 08:43:01 INFO - Running post-action listener: _start_resource_monitoring 08:43:01 INFO - Starting resource monitoring. 08:43:01 INFO - [mozharness: 2017-03-16 15:43:01.723929Z] Finished create-virtualenv step (success) 08:43:01 INFO - [mozharness: 2017-03-16 15:43:01.724396Z] Running install step. 08:43:01 INFO - Running pre-action listener: _resource_record_pre_action 08:43:01 INFO - Running main action method: install 08:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:01 INFO - Reading from file tmpfile_stdout 08:43:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:02 INFO - Reading from file tmpfile_stdout 08:43:02 INFO - Output received: 08:43:02 INFO - Usage: mozinstall [options] installer 08:43:02 INFO - Options: 08:43:02 INFO - -h, --help show this help message and exit 08:43:02 INFO - -d DEST, --destination=DEST 08:43:02 INFO - Directory to install application into. [default: 08:43:02 INFO - "/builds/slave/test"] 08:43:02 INFO - --app=APP Application being installed. [default: firefox] 08:43:02 INFO - mkdir: /builds/slave/test/build/application 08:43:02 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'] 08:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:43:17 INFO - Reading from file tmpfile_stdout 08:43:17 INFO - Output received: 08:43:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:17 INFO - Running post-action listener: _resource_record_post_action 08:43:17 INFO - [mozharness: 2017-03-16 15:43:17.434813Z] Finished install step (success) 08:43:17 INFO - [mozharness: 2017-03-16 15:43:17.435082Z] Running run-tests step. 08:43:17 INFO - Running pre-action listener: _resource_record_pre_action 08:43:17 INFO - Running main action method: run_tests 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:17 INFO - Python 2.7.3 08:43:17 INFO - Return code: 0 08:43:17 INFO - grabbing minidump binary from tooltool 08:43: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')]} 08:43:17 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 0x22a1290>, '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 0x22a1b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a2040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:17 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 08:43:17 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 08:43:17 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 08:43:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:17 INFO - Return code: 0 08:43:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: RUST_BACKTRACE is now 1 08:43:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:43:17 INFO - Using env: {'DISPLAY': ':0', 08:43:17 INFO - 'HOME': '/home/cltbld', 08:43:17 INFO - 'LANG': 'en_US.UTF-8', 08:43:17 INFO - 'LANGUAGE': 'en_US:en', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MAIL': '/var/mail/cltbld', 08:43:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:17 INFO - 'RUST_BACKTRACE': '1', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SHLVL': '1', 08:43:17 INFO - 'TERM': 'linux', 08:43:17 INFO - 'TMOUT': '86400', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - '_': '/tools/buildbot/bin/python'} 08:43:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:43:17 INFO - mozversion application_buildid: 20170316143604 08:43:17 INFO - mozversion application_changeset: 468dde25160493591211fe0505dd2ccdd6c9a0bb 08:43:17 INFO - mozversion application_display_name: Nightly 08:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:17 INFO - mozversion application_name: Firefox 08:43:17 INFO - mozversion application_remotingname: firefox 08:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:43:17 INFO - mozversion application_vendor: Mozilla 08:43:17 INFO - mozversion application_version: 55.0a1 08:43:17 INFO - mozversion platform_buildid: 20170316143604 08:43:17 INFO - mozversion platform_changeset: 468dde25160493591211fe0505dd2ccdd6c9a0bb 08:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:43:17 INFO - mozversion platform_version: 55.0a1 08:43:17 INFO - using testdate: 1489678997 08:43:17 INFO - actual date: 1489678997 08:43:17 INFO - starting webserver on 'localhost:44804' 08:43:17 INFO - SUITE-START | Running 2 tests 08:43:17 INFO - TEST-START | dromaeo_css 08:43:17 INFO - operating with platform_type : linux_ 08:43:17 INFO - Initialising browser for dromaeo_css test... 08:43:17 INFO - TEST-INFO | started process 30303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBx1aXD/profile http://localhost:44804/getInfo.html) 08:43:21 INFO - PID 30303 | __metrics Screen width/height:1600/1200 08:43:21 INFO - PID 30303 | colorDepth:24 08:43:21 INFO - PID 30303 | Browser inner width/height: 1024/697 08:43:21 INFO - PID 30303 | __metrics 08:43:22 ERROR - PID 30303 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:43:23 INFO - TEST-INFO | 30303: exit 0 08:43:23 INFO - Browser initialized. 08:43:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:23 INFO - TEST-INFO | started process 30434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBx1aXD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:35 INFO - PID 30434 | RSS: Main: 159027200 08:43:35 INFO - PID 30434 | 08:46:39 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44804/tests/dromaeo/cssquery-ext.html) 08:46:41 INFO - PID 30434 | RSS: Main: 164802560 08:46:41 INFO - PID 30434 | 08:48:23 INFO - PID 30434 | ************************* 08:48:23 INFO - PID 30434 | A coding exception was thrown and uncaught in a Task. 08:48:23 INFO - PID 30434 | 08:48:23 ERROR - PID 30434 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:48:23 INFO - PID 30434 | Full stack: 08:48:23 INFO - PID 30434 | ************************* 08:49:43 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-ext.html (next: http://localhost:44804/tests/dromaeo/cssquery-jquery.html) 08:49:44 INFO - PID 30434 | RSS: Main: 160706560 08:49:44 INFO - PID 30434 | 08:52:46 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44804/tests/dromaeo/cssquery-mootools.html) 08:52:47 INFO - PID 30434 | RSS: Main: 168837120 08:52:47 INFO - PID 30434 | 08:55:49 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44804/tests/dromaeo/cssquery-prototype.html) 08:55:49 INFO - PID 30434 | RSS: Main: 160882688 08:55:49 INFO - PID 30434 | 08:58:52 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44804/tests/dromaeo/cssquery-yui.html) 08:58:53 INFO - PID 30434 | RSS: Main: 169971712 08:58:53 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | Cycle 1(1): loaded http://localhost:44804/tests/dromaeo/cssquery-yui.html (next: http://localhost:44804/tests/dromaeo/cssquery-dojo.html) 09:01:56 INFO - PID 30434 | RSS: Main: 162553856 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | __start_tp_report 09:01:56 INFO - PID 30434 | _x_x_mozilla_page_load 09:01:56 INFO - PID 30434 | _x_x_mozilla_page_load_details 09:01:56 INFO - PID 30434 | |i|pagename|runs| 09:01:56 INFO - PID 30434 | |0;dojo.html;2664.7734942529883;2670.652815134032;2682.8524431156293;2713.4437440324746;2720.183944816555;4893.192623217174;5001.699898006118;5035.420926593443;5056.873578160548;5078.212877004065;4894.363732714742;5025.84922452327;5067.797288108472;5088.567471764904;5103.719295438749;4597.379353787238;4600.97699511502;4635.397398338211;4641.350210970467;4651.1162879053045;4637.0725854829;4654.720716756989;4655.4878963314;4668.9766551167195;4702.412198475191;4505.36924830524;4538.954610453886;4546.113507865967;4603.12540617285;4614.607758340511;4629.675922685414;4635.304704294383;4635.884102897421;4677.74272415017;4678.929816052762;4565.885852853672;4587.747673877935;4600.056988317387;4621.861344159681;4660.813567457298;4882.560569548722;4930.112579735646;4961.206207006861;4988.276699878497;5010.624203184776;5360.705161216131;5362.034833729927;5367.677939323614;5407.648502847303;5409.756560954766;5332.24687726693;5379.596530260246;5379.865503362408;5384.596155288369;5388.057090009272;4897.510248975074;4946.332245146931;5018.824341148043;5027.522385373383;5036.622253330942;5550.5282051026115;5556.860843527067;5560.610757247035;5576.693281869536;5588.692621905834;5101.617378696538;5156.535911767959;5312.76092575835;5376.1398176291605;5379.946200538023;5330.626856120112;5404.648697834628;5412.296401467784;5414.6209765316835;5441.755121019563;5117.769700363493;5223.712695801692;5299.33758280215;5380.2736630555155;5397.190421436816;5273.709945952933;5292.126799078186;5316.973415132899;5345.9842629900195;5356.196570514454;4567.2464043432465;4570.748608826547;4576.405067341291;4577.29051996941;4610.40064791575;3877.96122038776;3907.374820028782;3925.352316867742;3936.075022369741;3962.6037396260144;4667.95332046682;4706.082313948816;4706.247000479907;4721.480637129913;4725.929111063337;5375.139977603643;5443.618946673695;5456.699881506555;5457.945420545744;5485.232067510552;4570.9314360284625;4685.765711714401;4694.624430045588;4696.225122854691;4703.95296047042;4787.3776409066595;4892.339534162842;4910.189818679878;4928.630352723489;4935.407751069894;5017.247412888096;5021.84934451967;5023.974880125649;5038.722870242025;5074.594032477319;5347.545458636059;5398.244245805512;5432.076546986943;5455.099908515209;5467.45325467466;4900.215965445512;4924.03981223658;4926.261060840902;4942.4810394909455;4943.8516844494725;5132.127538318569;5208.947910520847;5215.243789650555;5219.869503262449;5237.135872580981;5207.531322181022;5260.0531904257605;5272.578193744568;5327.786888524415;5335.066363386314;5226.294450249167;5235.1623740201385;5261.710605916712;5271.393789714232;5302.522772950453;5187.170052791535;5192.065428222956;5201.1678131498775;5216.556592689664;5235;4997.575206107376;5068.847934561969;5074.314967479343;5122.513361230677;5132.486751324837;5155.845324640267;5270.631055826056;5283.788648454019;5283.867903302448;5320.228566857862;5090.720010399464;5127.435982042047;5131;5134.691918484903;5139.665921715076 09:01:56 INFO - PID 30434 | |1;ext.html;636.369993706231;668.3083009085597;690.7099018412268;805.4965646470955;817.0318172965033;33238.50142247865;33939.830300848495;33983.490247646245;34052;34100.488492672564;30214.84892575534;30548.389032219344;30559;30598.694013059863;30636.080917572453;6312.400321969406;6477.643729594871;8929.508877011762;9154.13035761605;9162.725118246462;9157.862632060524;9340.392874463138;9351.111644393772;9360.672376466826;9378.624855005792;9349;9359.064093590654;9385.483798391086;9458;9471.384360016611;9367.76580585484;9382.343235973485;9392.62429502819;9520.523973801352;9578.233741300679;9235.1688348049;9241.953790231073;9279.304052196112;9320.580573874191;9332.160105590461;34431.48352774711;34599.4810077849;34670;34818.82590587056;34828.651713482795;3300.1914530939835;3324.4514655081884;3375.9831200843837;3438.9656103438897;3446.3451944130534;24493.755062449327;24815.62776558353;24887.751122488724;24976.875115624487;25357.873210634014;3320.867165313409;3431.3995050865997;3542.3800834853796;3544.769589976669;3545.2377738786026;116814;118525.66634501469;120413.39793300978;165160.17419912943;165952;37113;37121.81439092787;37596;37639;37701.43447848284;39102.41346379807;39156.216875662896;39183.216335673125;39215.60784392119;39236.411453828216;12105.87894121065;12264.32546209967;12288.1398302118;12362.196457230251;13083.934580327037;10616.203784716177;10626.787464250672;10665.520051597698;10670.51982660782;10692.946535267274;13403.463861445627;13464.865351346361;13516.189028658311;13516.729665406638;13671.931640341734;5603.607747457639;5642.463965923231;5703.315602127771;5746.942530574641;5784.855378615568;882.9337799665051;899.123354729147;913.3150137396952;917.6696389299847;938.9906100938903;21647.242346517796;22472.438189045406;22654.093836246364;22770.506260369515;22863.771362286163;959.932804703664;972.5862223595091;981.5043403081398;992.712113487095;1002.1832206751474;12058.15592908488;12097.455614497192;12163.635090947286;12175.878241217475;12180.512779488898;247119;247880;248667;248874;250188.74905625355;43722.781386093506;44153.33769993389;44227.33658995118;44340.45276377882;44358;1230.5139469909336;1259.024256201433;1264.323586880996;1271.68207948013;1334.5462542735515;20990.160393584087;21038.0532876024;22282.108715651193;22356.217532386287;22378.216762413238;32537.67462325441;32620.510692340107;32657.510137347483;32665;32683;225777;226968;227620;228403;229435;22683.546329072997;22945.099333113743;25646;25971;29139.562906555995;30920.226994325323;30996.22509437192;31026.844865775525;31097.378052438373;31480.527792083594;28822.711772882;28850.567241491815;28864.278393040342;29011.7098829009;29624.259393515335;28998.42003159967;29166;29290.121296361143;30069.3986120272;30466.695333046388;28771.136865894056;28860.855695721388;28880;29430.705692942796;29595.112146635634;24750.504989900463;25416.745832542176;28379.57430638501;28435.573466397607;28700.125483060354;22492.775072249067;22589.096436143027;22769.544609108056;22817.543649127256;22934 09:01:56 INFO - PID 30434 | |2;jquery.html;398.8065788092774;406.54263953052816;419.13448728375903;431.2173405269436;431.58352190136515;18752.718709219374;18794.15426305816;19500.122494487747;19545.120469578884;19569.51076223095;18560.81439185611;18907.810921890778;19082.713759293623;19252.13365398557;19265.422037338867;5597.44025597441;5995.430434108753;6012.939870601282;6070.089486577004;6092.360302168275;5917.674527900964;6030.396960303957;6036.607620504675;6696;6972.407345375624;6991.89512157318;6998;7013.964930175342;7016.964915175443;7031.683574239171;6805.387515123638;7026;7064.576125432491;7080.362767350963;7092.326229008288;6652.268250492442;6865.382115609619;6904.378605925491;6979.267176946449;7036.331548502884;22661.206857760066;22810.65784013241;23059.884700576556;23406.297811065695;23573.528529429488;2230.353197572702;2382.1900553811615;2420.515896820625;2425.866577338246;2433.1605596069326;14196.645083872883;14199.148051116967;14445.566633001026;14510.782338264935;15034.398624055024;1852.1202428846325;1871.4011516314786;1886.6981282994793;1893.715942608606;1899.857510686704;88218.55890720569;90744;91158.54420727854;91300;92873.31956824983;16072.437464688679;16399.344026239054;16477.363621820692;16676.58308542296;16734.4142954996;29000.7099928998;29061.564076538867;29113.708862911524;29132.126036218946;29316.26709332241;8553.31573474133;8630.870536941951;8762.693305734269;9023.052579479061;9157.542122893961;6999.895001574981;7022.92977070233;7089.113860767404;7260.600666963368;7263.673134708845;8926.955365223132;8937.285017198608;9013.684521041732;9103.726888193365;9319.347645664873;3439.6216416194197;3554.680078792869;3660.103274697716;3861.7489863158803;3909.58949310324;850.9446885952393;860.1269711242968;875.7635438431715;886.1625763653415;892.3664198419066;18055.583325002448;18371.81628183701;19188.80811191898;19362.322318718776;19409.126589303516;866.4887716247445;879.384430898361;884.6770928611139;927.6892241099173;927.8144371125802;9638.90361096394;9650.71047868565;10047.397156170508;10115.797684046278;10204.642837500653;470335;479714;487958;489838;507047;88807;91563.08436915679;91652.54173729089;91955;92008;1162.4993244139657;1167.2937872587133;1197.7963746163173;1197.9820302695466;1205.7889869272842;15859.52421427359;15991.920040399724;16119.919400402923;16157.596060098122;16645.16774161263;40762.79618601888;41407;41498.37752433655;41948.3707744378;42533.36199956941;55027.724861375435;55421.72289138528;56711.43288567061;57269.71365143148;58349;6618.602883826986;8607.956960215159;9673.742413486201;10114.494275286354;10659.626913058006;11741.354225517678;11782.587609433629;11915.582954596548;11924.642260732191;12256.87743122593;10638.14894808398;10686.519106640375;10718.142548595937;10908.945455272673;11123.94438027837;10684.25210235276;10729.517171727448;10755.247132700635;10762.408067556047;10794.838077428687;10514.684559463229;10610.8408373876;10804.189685773756;10853.457327133454;11102.444877756241;10676.306040107369;10688;10702.83945740799;10707.839382409114;11099.445027748741;10761.085307748928;10847.620333288298;10928.562857485611;11121.944390277997;11233.045191158517 09:01:56 INFO - PID 30434 | |3;mootools.html;1432.591711362262;1450.4343306110618;1462.5173692681424;1481.6444053427178;1524.001778834863;8326.250637442628;8484.745457636265;8953.507557084358;9301.720948371543;9344.906550934496;9049.3665443419;9463.574139163737;9484.241260699146;9489.38319009264;9492.477913714743;2002.729631499747;2035.5013021809677;2045.754509458867;2056.845736569756;2057.783932687069;1975.5258737902943;2025.2101680344676;2043.8671486353414;2044.2845004248543;2050.6411378008866;2012.0945574491464;2027.3005812994493;2031.187524990001;2034.2778313698645;2048.9077991490417;1976.21939333963;1981.5838673878502;1996.211496458898;2002.7096071069614;2003.1186278037617;1933.4006457997925;1988.6122206169803;1992.9601407971904;2027.9898600507051;2037.3684157911096;9674.419534827934;9716.271279653984;9725.708228753148;9728.90271097287;9736.075072868067;4779.784909679072;4918.754062296871;4940.876478088041;4960.826371077031;4973.104841128596;2651.708312085669;2842.1757690269797;2886.5958765772807;2892.638420197475;2961.6890226526334;1050.9054185123375;1104.5471356743776;1127.2503784982976;1143.3197247637643;1154.5554961339944;13894.444222231099;14077.084989475652;14199.78700319496;14221.928890355483;14235.644108897257;3919.8236079376497;4198.1393814268;4223.070924396628;4239.215745087169;4279.529251782302;11775.99904008169;11788.587399440978;11800.645980620595;11840.526378944745;11842.348670823187;4880.41435027799;4887.340209071801;4919.237518184687;4996.150654388763;5004.049230646166;3824.464574959508;3896.1428485733095;4226.598473145046;4334.9783251083545;4431.911361772811;3533.258015816656;3590.263995880838;3638.890833275006;3698.5007024051947;3706.184639379332;1030.7938412317567;1038.9896101039044;1041.416806588313;1054.520193312041;1062.4209805655937;673.6463356737752;692.4460431654657;694.8888177891513;707.0419581467141;753.3220101908216;5597.076482380362;5597.216389705444;5658.292713410824;5702.087665973508;5906.468417842415;896.8116695493889;926.4395041000232;935.6725146198912;954.7183580843667;983.9163671087895;3649.799261040615;3705.6294370562728;3721.3673675475234;3762.2287431076566;3831.310364134427;12100.81848772269;12422.068344874171;12501;12515.561955331701;12525.93737031309;12263.75472490563;12276.32480213579;12391.690207744698;12397.690057748629;12404.503819847105;8364.247217750431;8697.95651021741;8700.956495217484;8706.738797836075;8963.327750418744;5545.3622833374675;5967.49276311501;6100.420460056288;6129.417705317987;6190.9879289230275;10704.8929510707;10738.946305268424;10847;10869.782604348027;11002.724931876766;10997.230193886351;11141.275817071864;11158.274712143684;11336.319820810448;11340.922612351813;6725.327467253235;6879.3120687930805;7747.92252077472;8204.138565450781;8385.622646981023;8672.913270867462;8782.077881822317;8844.115588441104;8856.822863542822;8856.867146992929;7726.729564465217;7887.566183859943;7892.881606775788;8007.519548827089;8110.607370825503;7781.144074151952;7787.18234585383;7838.490498117604;7844.6077696113825;7944.880826787487;6863.6568171590225;6874.2782007890455;6907.930920690729;6909.170899491892;6972.825679357854;4995.900081998267;5038.949610503994;5039.5968322534845;5097.235414687826;5162.045021671003;4785.425748910014;4788.6408519361885;4874.6344024197615;4920.360353154067;4924.089043526959 09:01:56 INFO - PID 30434 | |4;prototype.html;368.7990045425243;370.7627118644068;379.8879330597474;381.427858212681;395.45624765946843;5325.600579956499;5400.864978375537;5454.427285135058;5458.481444262794;5532.944670553294;5234.816781412651;5256;5313.814016509423;5335.1197052486295;5336.9733151334285;4291.463567054118;4431.224535706255;4461.709988850715;4472.82108715651;4473.530279320657;4420.877978570288;4426.2254105531565;4449.5327990560845;4465.37484752135;4468.486124095722;4439.2453282941815;4455.576720211575;4478.193925093482;4481.529439408864;4485.775711214443;4220.155968806221;4419.845305414295;4459.35339375792;4469.910601787962;4484.9551504485025;4097.303458412077;4103.712740108193;4112.498937887679;4130.401091841666;4141.192467468844;5225.268462415227;5228.92156617651;5268.394134674523;5274.683518988834;5281.419043905167;5048.949510504922;5188.507091826271;5220.8694782630355;5223.3209682741;5224.660397074216;5675.6878371689545;5676.205331253628;5678.290213723285;5678.716064196815;5690.2887139107615;4537.593346062698;4541.477730061052;4546.38623785788;4557.772111394417;4564.338170965191;5844.590878638497;5920.911186332165;5924.881502369928;5969.791057312973;5991.790287339966;4680.5085466025575;4695.7886895089805;4704.600108990706;4704.694194877322;4716.316134160596;4780.211265141213;4784.976075119672;4802.231642937113;4812.181929071996;4816.903661926742;5015.548600625962;5122.282880396748;5150.459201783834;5168.870778230499;5196.596918831894;5685.289338832646;5686.2039314496005;5702;5709.314882214161;5714.79998200061;1652.4629495414038;1655.2303179021571;1679.41220572801;1687.7215259482293;1688.8009513245488;1217.73209893825;1251.960872475843;1253.2918900821007;1262.6401475579416;1266.8099785032318;4963.032208719337;4966.230234313615;4992.276119962585;5013.548780609763;5016.573591244712;5866.8533286667325;5889.970550147307;5891.646501209942;5893.850699113632;5899.292084949833;4698.7415692137265;4930.408350997832;4947.505249475023;4950.415866922623;4990.72551009698;3071.8310492923106;3128.9374212515622;3132.9216769580944;3139.293658926769;3141.3874294512807;5165.690058596496;5404.297851074462;5430.022595932691;5435.456454354533;5447.210154527651;5719.370869204384;6000.559865632217;6021.189552082262;6023.6385816851125;6046.455818976313;5282.4680842556;5352.812651557177;5377.7580008899695;5412.188171774108;5442.782288708487;5807.767689292381;5843.29880414353;5889.969255380377;5892.7642894283745;5922.911156332744;5675.404082571271;5728;5765.596408251382;5794.768209271582;5815.680137592473;5383.488568585978;5409.215663728816;5413.377461591967;5424.783008679608;5437.972810135924;4659.953400465952;4704.3649107370065;4706.705655944643;4712.929306060343;4716.410448693913;5741.224934633938;5849.61977471463;5883;5885.205497257986;5900.64596124234;5668;5675.091985282335;5678.268128220767;5705.774747848425;5707.0583353747825;5496.972515137399;5593.161025846156;5669.4047125051275;5678.46681396029;5683.175939488834;5527.723613819373;5537.529310008695;5546.861328466821;5553.111502159797;5586.664800112007;5707.4577915098;5717.514011309086;5730;5741.598088133791;5750.166225897305;5334.786608535615;5540.390557038803;5572.0527510324155;5573.498385145356;5592.664440133605 09:01:56 INFO - PID 30434 | |5;yui.html;659.337365947223;679.9320067993201;681.366329313738;694.7568351077124;706.1420374245291;12772.361381930901;13486.662833429169;13490.25803580805;13516.594502164926;13592.592222233336;12701.428435720392;12739.808902866464;12894.80657790134;12900.80648790269;13063;795.6220795122329;824.6618886256636;829.7925518620345;831.683960095163;835.3442547600135;852.7356519478982;856.4604299291437;859.3554833874595;859.7420773767844;861.0313397427893;882.9028806831243;885.2254277507182;886.171429713217;886.4592598514932;888.2183678363032;872.358816270041;873.1094283830521;875.8335916175906;877.0659247900965;878.1525827576387;638.9872202555923;640.5388120553195;646.0309535696455;646.3439608797074;646.9417752402306;14214.85785142156;14402;14423.855761442355;14429.71140577193;14555.490557830424;13334.133281336683;13411.664708382272;14108.858911410856;14158.433662653482;14320.928395357956;10325.586976521005;10479.181320150974;10602;10854.131669466502;10997.835032474439;3248.586864713857;3253.186703324169;3281.1797050737314;3288.2765791525826;3288.6546912574313;61894.38105618976;61907.85074894969;62164.68917655428;62799;62918;10474.895251047545;10523.21075919309;10554.10290125348;10705.357678539312;11196.104311655048;21387.8930605346;21536.892315538636;21548.461288467915;21652.891735541223;21892.45268868259;6329.525285603599;6428.067930150102;6500.122483464766;6527.314631963671;6529.314421985718;3458.360203362386;3464.237867669159;3538.433850583894;3552.8223588820456;3569.839357228931;2830.674472435655;2836.4894319022774;2879.7264259895696;2895.6525216974096;2898.3044069423186;476.5877515948749;483.66868694944077;484.7406637448948;486.1274013146411;489.56428778387266;607.1621162795315;629.2449061126575;634.4607083978582;642.2549842183046;658.7035833874776;8455;8905.376623636414;9202.171804537624;9252.907470925205;9318.534073296309;586.1354502109355;607.9996810493516;614.3579958942915;617.7992152550349;627.5105417774143;4142.378643203483;4260.026290334557;4281.250781113355;4284.228838809045;4291.506476755213;47957.52042479531;48737.268940965914;48909;55537.44462555404;59702.10446843301;54461;54738;55370.72314638401;56092;56513;47164.7641761789;47695.99999999931;48588;49069;50095.24857127146;8038.236367545074;8338.499690018618;8430.45202061864;8438.919794274923;8524.659013639384;34412.82793586116;34771.478427824106;34840;35251.118722031126;35251.47122793109;40058.599414006654;40825.38761918633;40850.59149408587;41758.791206043774;41935;10428.478576071015;10576.947115264375;10670.0930420912;10675.092617127631;10925.125989920945;10633.361998280128;10671.89328106709;10769.461526923778;11446.255993360404;11457.770844582896;10584.735381615521;10730;10801.621943231949;10988.340699558052;11138.721531961766;10480.68557943263;10651.89348106509;10679.19906007037;10946.507407166537;10958.178136639943;10735.785284294427;10757.085647719718;10762.813940292786;10773.107330089319;10941.124710023338;8803.515806630698;8811.691590794291;8846.248068914214;8913.153250441197;9104.362694611315;8352.019888129273;8380.287675547403;8737.91262087371;9046.909530904606;9132.132447417485 09:01:56 INFO - PID 30434 | __end_tp_report 09:01:56 INFO - PID 30434 | __start_cc_report 09:01:56 INFO - PID 30434 | _x_x_mozilla_cycle_collect,381 09:01:56 INFO - PID 30434 | __end_cc_report 09:01:56 INFO - PID 30434 | __startTimestamp1489680116447__endTimestamp 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | ------- Summary: start ------- 09:01:56 INFO - PID 30434 | Number of tests: 6 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#0] dojo.html Cycles:165 Average:4951.15 Median:5068.85 stddev:532.85 (10.5%) stddev-sans-first:503.39 09:01:56 INFO - PID 30434 | Values: 2664.8 2670.7 2682.9 2713.4 2720.2 4893.2 5001.7 5035.4 5056.9 5078.2 4894.4 5025.8 5067.8 5088.6 5103.7 4597.4 4601.0 4635.4 4641.4 4651.1 4637.1 4654.7 4655.5 4669.0 4702.4 4505.4 4539.0 4546.1 4603.1 4614.6 4629.7 4635.3 4635.9 4677.7 4678.9 4565.9 4587.7 4600.1 4621.9 4660.8 4882.6 4930.1 4961.2 4988.3 5010.6 5360.7 5362.0 5367.7 5407.6 5409.8 5332.2 5379.6 5379.9 5384.6 5388.1 4897.5 4946.3 5018.8 5027.5 5036.6 5550.5 5556.9 5560.6 5576.7 5588.7 5101.6 5156.5 5312.8 5376.1 5379.9 5330.6 5404.6 5412.3 5414.6 5441.8 5117.8 5223.7 5299.3 5380.3 5397.2 5273.7 5292.1 5317.0 5346.0 5356.2 4567.2 4570.7 4576.4 4577.3 4610.4 3878.0 3907.4 3925.4 3936.1 3962.6 4668.0 4706.1 4706.2 4721.5 4725.9 5375.1 5443.6 5456.7 5457.9 5485.2 4570.9 4685.8 4694.6 4696.2 4704.0 4787.4 4892.3 4910.2 4928.6 4935.4 5017.2 5021.8 5024.0 5038.7 5074.6 5347.5 5398.2 5432.1 5455.1 5467.5 4900.2 4924.0 4926.3 4942.5 4943.9 5132.1 5208.9 5215.2 5219.9 5237.1 5207.5 5260.1 5272.6 5327.8 5335.1 5226.3 5235.2 5261.7 5271.4 5302.5 5187.2 5192.1 5201.2 5216.6 5235.0 4997.6 5068.8 5074.3 5122.5 5132.5 5155.8 5270.6 5283.8 5283.9 5320.2 5090.7 5127.4 5131.0 5134.7 5139.7 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#1] ext.html Cycles:180 Average:34439.11 Median:30778.15 stddev:54834.47 (178.2%) stddev-sans-first:54929.55 09:01:56 INFO - PID 30434 | Values: 636.4 668.3 690.7 805.5 817.0 33238.5 33939.8 33983.5 34052.0 34100.5 30214.8 30548.4 30559.0 30598.7 30636.1 6312.4 6477.6 8929.5 9154.1 9162.7 9157.9 9340.4 9351.1 9360.7 9378.6 9349.0 9359.1 9385.5 9458.0 9471.4 9367.8 9382.3 9392.6 9520.5 9578.2 9235.2 9242.0 9279.3 9320.6 9332.2 34431.5 34599.5 34670.0 34818.8 34828.7 3300.2 3324.5 3376.0 3439.0 3446.3 24493.8 24815.6 24887.8 24976.9 25357.9 3320.9 3431.4 3542.4 3544.8 3545.2 116814.0 118525.7 120413.4 165160.2 165952.0 37113.0 37121.8 37596.0 37639.0 37701.4 39102.4 39156.2 39183.2 39215.6 39236.4 12105.9 12264.3 12288.1 12362.2 13083.9 10616.2 10626.8 10665.5 10670.5 10692.9 13403.5 13464.9 13516.2 13516.7 13671.9 5603.6 5642.5 5703.3 5746.9 5784.9 882.9 899.1 913.3 917.7 939.0 21647.2 22472.4 22654.1 22770.5 22863.8 959.9 972.6 981.5 992.7 1002.2 12058.2 12097.5 12163.6 12175.9 12180.5 247119.0 247880.0 248667.0 248874.0 250188.7 43722.8 44153.3 44227.3 44340.5 44358.0 1230.5 1259.0 1264.3 1271.7 1334.5 20990.2 21038.1 22282.1 22356.2 22378.2 32537.7 32620.5 32657.5 32665.0 32683.0 225777.0 226968.0 227620.0 228403.0 229435.0 22683.5 22945.1 25646.0 25971.0 29139.6 30920.2 30996.2 31026.8 31097.4 31480.5 28822.7 28850.6 28864.3 29011.7 29624.3 28998.4 29166.0 29290.1 30069.4 30466.7 28771.1 28860.9 28880.0 29430.7 29595.1 24750.5 25416.7 28379.6 28435.6 28700.1 22492.8 22589.1 22769.5 22817.5 22934.0 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#2] jquery.html Cycles:180 Average:29952.33 Median:3497.15 stddev:80343.40 (2297.4%) stddev-sans-first:80538.14 09:01:56 INFO - PID 30434 | Values: 398.8 406.5 419.1 431.2 431.6 18752.7 18794.2 19500.1 19545.1 19569.5 18560.8 18907.8 19082.7 19252.1 19265.4 5597.4 5995.4 6012.9 6070.1 6092.4 5917.7 6030.4 6036.6 6696.0 6972.4 6991.9 6998.0 7014.0 7017.0 7031.7 6805.4 7026.0 7064.6 7080.4 7092.3 6652.3 6865.4 6904.4 6979.3 7036.3 22661.2 22810.7 23059.9 23406.3 23573.5 2230.4 2382.2 2420.5 2425.9 2433.2 14196.6 14199.1 14445.6 14510.8 15034.4 1852.1 1871.4 1886.7 1893.7 1899.9 88218.6 90744.0 91158.5 91300.0 92873.3 16072.4 16399.3 16477.4 16676.6 16734.4 29000.7 29061.6 29113.7 29132.1 29316.3 8553.3 8630.9 8762.7 9023.1 9157.5 6999.9 7022.9 7089.1 7260.6 7263.7 8927.0 8937.3 9013.7 9103.7 9319.3 3439.6 3554.7 3660.1 3861.7 3909.6 850.9 860.1 875.8 886.2 892.4 18055.6 18371.8 19188.8 19362.3 19409.1 866.5 879.4 884.7 927.7 927.8 9638.9 9650.7 10047.4 10115.8 10204.6 470335.0 479714.0 487958.0 489838.0 507047.0 88807.0 91563.1 91652.5 91955.0 92008.0 1162.5 1167.3 1197.8 1198.0 1205.8 15859.5 15991.9 16119.9 16157.6 16645.2 40762.8 41407.0 41498.4 41948.4 42533.4 55027.7 55421.7 56711.4 57269.7 58349.0 6618.6 8608.0 9673.7 10114.5 10659.6 11741.4 11782.6 11915.6 11924.6 12256.9 10638.1 10686.5 10718.1 10908.9 11123.9 10684.3 10729.5 10755.2 10762.4 10794.8 10514.7 10610.8 10804.2 10853.5 11102.4 10676.3 10688.0 10702.8 10707.8 11099.4 10761.1 10847.6 10928.6 11121.9 11233.0 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#3] mootools.html Cycles:180 Average:5939.24 Median:4232.91 stddev:3831.13 (90.5%) stddev-sans-first:3826.92 09:01:56 INFO - PID 30434 | Values: 1432.6 1450.4 1462.5 1481.6 1524.0 8326.3 8484.7 8953.5 9301.7 9344.9 9049.4 9463.6 9484.2 9489.4 9492.5 2002.7 2035.5 2045.8 2056.8 2057.8 1975.5 2025.2 2043.9 2044.3 2050.6 2012.1 2027.3 2031.2 2034.3 2048.9 1976.2 1981.6 1996.2 2002.7 2003.1 1933.4 1988.6 1993.0 2028.0 2037.4 9674.4 9716.3 9725.7 9728.9 9736.1 4779.8 4918.8 4940.9 4960.8 4973.1 2651.7 2842.2 2886.6 2892.6 2961.7 1050.9 1104.5 1127.3 1143.3 1154.6 13894.4 14077.1 14199.8 14221.9 14235.6 3919.8 4198.1 4223.1 4239.2 4279.5 11776.0 11788.6 11800.6 11840.5 11842.3 4880.4 4887.3 4919.2 4996.2 5004.0 3824.5 3896.1 4226.6 4335.0 4431.9 3533.3 3590.3 3638.9 3698.5 3706.2 1030.8 1039.0 1041.4 1054.5 1062.4 673.6 692.4 694.9 707.0 753.3 5597.1 5597.2 5658.3 5702.1 5906.5 896.8 926.4 935.7 954.7 983.9 3649.8 3705.6 3721.4 3762.2 3831.3 12100.8 12422.1 12501.0 12515.6 12525.9 12263.8 12276.3 12391.7 12397.7 12404.5 8364.2 8698.0 8701.0 8706.7 8963.3 5545.4 5967.5 6100.4 6129.4 6191.0 10704.9 10738.9 10847.0 10869.8 11002.7 10997.2 11141.3 11158.3 11336.3 11340.9 6725.3 6879.3 7747.9 8204.1 8385.6 8672.9 8782.1 8844.1 8856.8 8856.9 7726.7 7887.6 7892.9 8007.5 8110.6 7781.1 7787.2 7838.5 7844.6 7944.9 6863.7 6874.3 6907.9 6909.2 6972.8 4995.9 5038.9 5039.6 5097.2 5162.0 4785.4 4788.6 4874.6 4920.4 4924.1 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#4] prototype.html Cycles:180 Average:4837.53 Median:5271.54 stddev:1294.96 (24.6%) stddev-sans-first:1254.40 09:01:56 INFO - PID 30434 | Values: 368.8 370.8 379.9 381.4 395.5 5325.6 5400.9 5454.4 5458.5 5532.9 5234.8 5256.0 5313.8 5335.1 5337.0 4291.5 4431.2 4461.7 4472.8 4473.5 4420.9 4426.2 4449.5 4465.4 4468.5 4439.2 4455.6 4478.2 4481.5 4485.8 4220.2 4419.8 4459.4 4469.9 4485.0 4097.3 4103.7 4112.5 4130.4 4141.2 5225.3 5228.9 5268.4 5274.7 5281.4 5048.9 5188.5 5220.9 5223.3 5224.7 5675.7 5676.2 5678.3 5678.7 5690.3 4537.6 4541.5 4546.4 4557.8 4564.3 5844.6 5920.9 5924.9 5969.8 5991.8 4680.5 4695.8 4704.6 4704.7 4716.3 4780.2 4785.0 4802.2 4812.2 4816.9 5015.5 5122.3 5150.5 5168.9 5196.6 5685.3 5686.2 5702.0 5709.3 5714.8 1652.5 1655.2 1679.4 1687.7 1688.8 1217.7 1252.0 1253.3 1262.6 1266.8 4963.0 4966.2 4992.3 5013.5 5016.6 5866.9 5890.0 5891.6 5893.9 5899.3 4698.7 4930.4 4947.5 4950.4 4990.7 3071.8 3128.9 3132.9 3139.3 3141.4 5165.7 5404.3 5430.0 5435.5 5447.2 5719.4 6000.6 6021.2 6023.6 6046.5 5282.5 5352.8 5377.8 5412.2 5442.8 5807.8 5843.3 5890.0 5892.8 5922.9 5675.4 5728.0 5765.6 5794.8 5815.7 5383.5 5409.2 5413.4 5424.8 5438.0 4660.0 4704.4 4706.7 4712.9 4716.4 5741.2 5849.6 5883.0 5885.2 5900.6 5668.0 5675.1 5678.3 5705.8 5707.1 5497.0 5593.2 5669.4 5678.5 5683.2 5527.7 5537.5 5546.9 5553.1 5586.7 5707.5 5717.5 5730.0 5741.6 5750.2 5334.8 5540.4 5572.1 5573.5 5592.7 09:01:56 INFO - PID 30434 | 09:01:56 INFO - PID 30434 | [#5] yui.html Cycles:180 Average:14106.08 Median:23820.68 stddev:16902.76 (71.0%) stddev-sans-first:16920.01 09:01:56 INFO - PID 30434 | Values: 659.3 679.9 681.4 694.8 706.1 12772.4 13486.7 13490.3 13516.6 13592.6 12701.4 12739.8 12894.8 12900.8 13063.0 795.6 824.7 829.8 831.7 835.3 852.7 856.5 859.4 859.7 861.0 882.9 885.2 886.2 886.5 888.2 872.4 873.1 875.8 877.1 878.2 639.0 640.5 646.0 646.3 646.9 14214.9 14402.0 14423.9 14429.7 14555.5 13334.1 13411.7 14108.9 14158.4 14320.9 10325.6 10479.2 10602.0 10854.1 10997.8 3248.6 3253.2 3281.2 3288.3 3288.7 61894.4 61907.9 62164.7 62799.0 62918.0 10474.9 10523.2 10554.1 10705.4 11196.1 21387.9 21536.9 21548.5 21652.9 21892.5 6329.5 6428.1 6500.1 6527.3 6529.3 3458.4 3464.2 3538.4 3552.8 3569.8 2830.7 2836.5 2879.7 2895.7 2898.3 476.6 483.7 484.7 486.1 489.6 607.2 629.2 634.5 642.3 658.7 8455.0 8905.4 9202.2 9252.9 9318.5 586.1 608.0 614.4 617.8 627.5 4142.4 4260.0 4281.3 4284.2 4291.5 47957.5 48737.3 48909.0 55537.4 59702.1 54461.0 54738.0 55370.7 56092.0 56513.0 47164.8 47696.0 48588.0 49069.0 50095.2 8038.2 8338.5 8430.5 8438.9 8524.7 34412.8 34771.5 34840.0 35251.1 35251.5 40058.6 40825.4 40850.6 41758.8 41935.0 10428.5 10576.9 10670.1 10675.1 10925.1 10633.4 10671.9 10769.5 11446.3 11457.8 10584.7 10730.0 10801.6 10988.3 11138.7 10480.7 10651.9 10679.2 10946.5 10958.2 10735.8 10757.1 10762.8 10773.1 10941.1 8803.5 8811.7 8846.2 8913.2 9104.4 8352.0 8380.3 8737.9 9046.9 9132.1 09:01:56 INFO - PID 30434 | -------- Summary: end -------- 09:01:56 INFO - PID 30434 | 09:01:57 INFO - TEST-INFO | 30434: exit 0 09:01:57 INFO - TEST-OK | dromaeo_css | took 1119548ms 09:01:57 INFO - TEST-START | kraken 09:01:57 INFO - operating with platform_type : linux_ 09:01:57 INFO - Initialising browser for kraken test... 09:01:57 INFO - TEST-INFO | started process 30813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoODEIU/profile http://localhost:44804/getInfo.html) 09:02:01 INFO - PID 30813 | __metrics Screen width/height:1600/1200 09:02:01 INFO - PID 30813 | colorDepth:24 09:02:01 INFO - PID 30813 | Browser inner width/height: 1024/697 09:02:01 INFO - PID 30813 | __metrics 09:02:02 ERROR - PID 30813 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:02:03 INFO - TEST-INFO | 30813: exit 0 09:02:03 INFO - Browser initialized. 09:02:03 INFO - Running cycle 1/1 for kraken test... 09:02:03 INFO - TEST-INFO | started process 30943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoODEIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:15 INFO - PID 30943 | RSS: Main: 158355456 09:02:15 INFO - PID 30943 | 09:02:17 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44804/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:18 INFO - PID 30943 | RSS: Main: 162312192 09:02:18 INFO - PID 30943 | 09:02:21 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44804/tests/kraken/driver.html?testName=audio-dft) 09:02:22 INFO - PID 30943 | RSS: Main: 161669120 09:02:22 INFO - PID 30943 | 09:02:25 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44804/tests/kraken/driver.html?testName=audio-fft) 09:02:25 INFO - PID 30943 | RSS: Main: 157544448 09:02:25 INFO - PID 30943 | 09:02:28 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44804/tests/kraken/driver.html?testName=audio-oscillator) 09:02:28 INFO - PID 30943 | RSS: Main: 157753344 09:02:28 INFO - PID 30943 | 09:02:30 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:31 INFO - PID 30943 | RSS: Main: 158306304 09:02:31 INFO - PID 30943 | 09:02:34 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44804/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:35 INFO - PID 30943 | RSS: Main: 163733504 09:02:35 INFO - PID 30943 | 09:02:38 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44804/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:39 INFO - PID 30943 | RSS: Main: 160415744 09:02:39 INFO - PID 30943 | 09:02:42 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44804/tests/kraken/driver.html?testName=json-parse-financial) 09:02:43 INFO - PID 30943 | RSS: Main: 161603584 09:02:43 INFO - PID 30943 | 09:02:44 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:45 INFO - PID 30943 | RSS: Main: 161943552 09:02:45 INFO - PID 30943 | 09:02:47 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:47 INFO - PID 30943 | RSS: Main: 161808384 09:02:47 INFO - PID 30943 | 09:02:50 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:50 INFO - PID 30943 | RSS: Main: 162488320 09:02:50 INFO - PID 30943 | 09:02:53 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:54 INFO - PID 30943 | RSS: Main: 162885632 09:02:54 INFO - PID 30943 | 09:02:57 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:58 INFO - PID 30943 | RSS: Main: 166084608 09:02:58 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | Cycle 1(1): loaded http://localhost:44804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44804/tests/kraken/driver.html?testName=ai-astar) 09:03:00 INFO - PID 30943 | RSS: Main: 167374848 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | __start_tp_report 09:03:00 INFO - PID 30943 | _x_x_mozilla_page_load 09:03:00 INFO - PID 30943 | _x_x_mozilla_page_load_details 09:03:00 INFO - PID 30943 | |i|pagename|runs| 09:03:00 INFO - PID 30943 | |0;ai-astar;112;118;117;119;120;119;121;118;119;118 09:03:00 INFO - PID 30943 | |1;audio-beat-detection;160;126;127;182;129;127;127;126;152;129 09:03:00 INFO - PID 30943 | |2;audio-dft;167;164;170;173;168;168;163;165;166;164 09:03:00 INFO - PID 30943 | |3;audio-fft;75;75;74;120;78;76;87;76;96;79 09:03:00 INFO - PID 30943 | |4;audio-oscillator;86;85;104;85;85;85;101;86;85;105 09:03:00 INFO - PID 30943 | |5;imaging-gaussian-blur;114;115;114;114;113;118;115;114;115;114 09:03:00 INFO - PID 30943 | |6;imaging-darkroom;151;150;150;150;150;150;150;150;151;152 09:03:00 INFO - PID 30943 | |7;imaging-desaturate;94;95;95;95;95;94;95;96;95;94 09:03:00 INFO - PID 30943 | |8;json-parse-financial;70;67;70;69;69;67;68;71;68;69 09:03:00 INFO - PID 30943 | |9;json-stringify-tinderbox;56;56;56;56;56;56;57;56;56;56 09:03:00 INFO - PID 30943 | |10;stanford-crypto-aes;85;89;83;81;83;82;84;85;83;83 09:03:00 INFO - PID 30943 | |11;stanford-crypto-ccm;140;138;133;141;136;146;133;149;180;138 09:03:00 INFO - PID 30943 | |12;stanford-crypto-pbkdf2;187;207;186;203;199;195;194;219;187;193 09:03:00 INFO - PID 30943 | |13;stanford-crypto-sha256-iterative;74;72;71;75;82;75;70;70;75;70 09:03:00 INFO - PID 30943 | __end_tp_report 09:03:00 INFO - PID 30943 | __start_cc_report 09:03:00 INFO - PID 30943 | _x_x_mozilla_cycle_collect,868 09:03:00 INFO - PID 30943 | __end_cc_report 09:03:00 INFO - PID 30943 | __startTimestamp1489680180321__endTimestamp 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | ------- Summary: start ------- 09:03:00 INFO - PID 30943 | Number of tests: 14 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#0] ai-astar Cycles:10 Average:118.10 Median:119.00 stddev:2.42 (2.0%) stddev-sans-first:1.20 09:03:00 INFO - PID 30943 | Values: 112.0 118.0 117.0 119.0 120.0 119.0 121.0 118.0 119.0 118.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:129.00 stddev:19.51 (15.1%) stddev-sans-first:19.08 09:03:00 INFO - PID 30943 | Values: 160.0 126.0 127.0 182.0 129.0 127.0 127.0 126.0 152.0 129.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#2] audio-dft Cycles:10 Average:166.80 Median:167.50 stddev:3.08 (1.8%) stddev-sans-first:3.27 09:03:00 INFO - PID 30943 | Values: 167.0 164.0 170.0 173.0 168.0 168.0 163.0 165.0 166.0 164.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:14.52 (18.9%) stddev-sans-first:15.07 09:03:00 INFO - PID 30943 | Values: 75.0 75.0 74.0 120.0 78.0 76.0 87.0 76.0 96.0 79.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:85.00 stddev:8.78 (10.3%) stddev-sans-first:9.15 09:03:00 INFO - PID 30943 | Values: 86.0 85.0 104.0 85.0 85.0 85.0 101.0 86.0 85.0 105.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.41 09:03:00 INFO - PID 30943 | Values: 114.0 115.0 114.0 114.0 113.0 118.0 115.0 114.0 115.0 114.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:03:00 INFO - PID 30943 | Values: 151.0 150.0 150.0 150.0 150.0 150.0 150.0 150.0 151.0 152.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 09:03:00 INFO - PID 30943 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 94.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.32 09:03:00 INFO - PID 30943 | Values: 70.0 67.0 70.0 69.0 69.0 67.0 68.0 71.0 68.0 69.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 09:03:00 INFO - PID 30943 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 56.0 56.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.20 (2.6%) stddev-sans-first:2.29 09:03:00 INFO - PID 30943 | Values: 85.0 89.0 83.0 81.0 83.0 82.0 84.0 85.0 83.0 83.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:140.50 stddev:13.84 (9.9%) stddev-sans-first:14.63 09:03:00 INFO - PID 30943 | Values: 140.0 138.0 133.0 141.0 136.0 146.0 133.0 149.0 180.0 138.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:197.00 stddev:10.40 (5.3%) stddev-sans-first:10.39 09:03:00 INFO - PID 30943 | Values: 187.0 207.0 186.0 203.0 199.0 195.0 194.0 219.0 187.0 193.0 09:03:00 INFO - PID 30943 | 09:03:00 INFO - PID 30943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.50 stddev:3.72 (5.0%) stddev-sans-first:3.94 09:03:00 INFO - PID 30943 | Values: 74.0 72.0 71.0 75.0 82.0 75.0 70.0 70.0 75.0 70.0 09:03:00 INFO - PID 30943 | -------- Summary: end -------- 09:03:00 INFO - PID 30943 | 09:03:01 INFO - TEST-INFO | 30943: exit 0 09:03:01 INFO - TEST-OK | kraken | took 64163ms 09:03:01 INFO - SUITE-END | took 1183s 09:03:01 INFO - Completed test suite (00:19:43) 09:03:01 INFO - javascript benchmark 09:03:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6758.181578209236, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.7734942529883, 2670.652815134032, 2682.8524431156293, 2713.4437440324746, 2720.183944816555, 4893.192623217174, 5001.699898006118, 5035.420926593443, 5056.873578160548, 5078.212877004065, 4894.363732714742, 5025.84922452327, 5067.797288108472, 5088.567471764904, 5103.719295438749, 4597.379353787238, 4600.97699511502, 4635.397398338211, 4641.350210970467, 4651.1162879053045, 4637.0725854829, 4654.720716756989, 4655.4878963314, 4668.9766551167195, 4702.412198475191, 4505.36924830524, 4538.954610453886, 4546.113507865967, 4603.12540617285, 4614.607758340511, 4629.675922685414, 4635.304704294383, 4635.884102897421, 4677.74272415017, 4678.929816052762, 4565.885852853672, 4587.747673877935, 4600.056988317387, 4621.861344159681, 4660.813567457298, 4882.560569548722, 4930.112579735646, 4961.206207006861, 4988.276699878497, 5010.624203184776, 5360.705161216131, 5362.034833729927, 5367.677939323614, 5407.648502847303, 5409.756560954766, 5332.24687726693, 5379.596530260246, 5379.865503362408, 5384.596155288369, 5388.057090009272, 4897.510248975074, 4946.332245146931, 5018.824341148043, 5027.522385373383, 5036.622253330942, 5550.5282051026115, 5556.860843527067, 5560.610757247035, 5576.693281869536, 5588.692621905834, 5101.617378696538, 5156.535911767959, 5312.76092575835, 5376.1398176291605, 5379.946200538023, 5330.626856120112, 5404.648697834628, 5412.296401467784, 5414.6209765316835, 5441.755121019563, 5117.769700363493, 5223.712695801692, 5299.33758280215, 5380.2736630555155, 5397.190421436816, 5273.709945952933, 5292.126799078186, 5316.973415132899, 5345.9842629900195, 5356.196570514454, 4567.2464043432465, 4570.748608826547, 4576.405067341291, 4577.29051996941, 4610.40064791575, 3877.96122038776, 3907.374820028782, 3925.352316867742, 3936.075022369741, 3962.6037396260144, 4667.95332046682, 4706.082313948816, 4706.247000479907, 4721.480637129913, 4725.929111063337, 5375.139977603643, 5443.618946673695, 5456.699881506555, 5457.945420545744, 5485.232067510552, 4570.9314360284625, 4685.765711714401, 4694.624430045588, 4696.225122854691, 4703.95296047042, 4787.3776409066595, 4892.339534162842, 4910.189818679878, 4928.630352723489, 4935.407751069894, 5017.247412888096, 5021.84934451967, 5023.974880125649, 5038.722870242025, 5074.594032477319, 5347.545458636059, 5398.244245805512, 5432.076546986943, 5455.099908515209, 5467.45325467466, 4900.215965445512, 4924.03981223658, 4926.261060840902, 4942.4810394909455, 4943.8516844494725, 5132.127538318569, 5208.947910520847, 5215.243789650555, 5219.869503262449, 5237.135872580981, 5207.531322181022, 5260.0531904257605, 5272.578193744568, 5327.786888524415, 5335.066363386314, 5226.294450249167, 5235.1623740201385, 5261.710605916712, 5271.393789714232, 5302.522772950453, 5187.170052791535, 5192.065428222956, 5201.1678131498775, 5216.556592689664, 5235.0, 4997.575206107376, 5068.847934561969, 5074.314967479343, 5122.513361230677, 5132.486751324837, 5155.845324640267, 5270.631055826056, 5283.788648454019, 5283.867903302448, 5320.228566857862, 5090.720010399464, 5127.435982042047, 5131.0, 5134.691918484903, 5139.665921715076], "value": 4915.352831014147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.369993706231, 668.3083009085597, 690.7099018412268, 805.4965646470955, 817.0318172965033, 33238.50142247865, 33939.830300848495, 33983.490247646245, 34052.0, 34100.488492672564, 30214.84892575534, 30548.389032219344, 30559.0, 30598.694013059863, 30636.080917572453, 6312.400321969406, 6477.643729594871, 8929.508877011762, 9154.13035761605, 9162.725118246462, 9157.862632060524, 9340.392874463138, 9351.111644393772, 9360.672376466826, 9378.624855005792, 9349.0, 9359.064093590654, 9385.483798391086, 9458.0, 9471.384360016611, 9367.76580585484, 9382.343235973485, 9392.62429502819, 9520.523973801352, 9578.233741300679, 9235.1688348049, 9241.953790231073, 9279.304052196112, 9320.580573874191, 9332.160105590461, 34431.48352774711, 34599.4810077849, 34670.0, 34818.82590587056, 34828.651713482795, 3300.1914530939835, 3324.4514655081884, 3375.9831200843837, 3438.9656103438897, 3446.3451944130534, 24493.755062449327, 24815.62776558353, 24887.751122488724, 24976.875115624487, 25357.873210634014, 3320.867165313409, 3431.3995050865997, 3542.3800834853796, 3544.769589976669, 3545.2377738786026, 116814.0, 118525.66634501469, 120413.39793300978, 165160.17419912943, 165952.0, 37113.0, 37121.81439092787, 37596.0, 37639.0, 37701.43447848284, 39102.41346379807, 39156.216875662896, 39183.216335673125, 39215.60784392119, 39236.411453828216, 12105.87894121065, 12264.32546209967, 12288.1398302118, 12362.196457230251, 13083.934580327037, 10616.203784716177, 10626.787464250672, 10665.520051597698, 10670.51982660782, 10692.946535267274, 13403.463861445627, 13464.865351346361, 13516.189028658311, 13516.729665406638, 13671.931640341734, 5603.607747457639, 5642.463965923231, 5703.315602127771, 5746.942530574641, 5784.855378615568, 882.9337799665051, 899.123354729147, 913.3150137396952, 917.6696389299847, 938.9906100938903, 21647.242346517796, 22472.438189045406, 22654.093836246364, 22770.506260369515, 22863.771362286163, 959.932804703664, 972.5862223595091, 981.5043403081398, 992.712113487095, 1002.1832206751474, 12058.15592908488, 12097.455614497192, 12163.635090947286, 12175.878241217475, 12180.512779488898, 247119.0, 247880.0, 248667.0, 248874.0, 250188.74905625355, 43722.781386093506, 44153.33769993389, 44227.33658995118, 44340.45276377882, 44358.0, 1230.5139469909336, 1259.024256201433, 1264.323586880996, 1271.68207948013, 1334.5462542735515, 20990.160393584087, 21038.0532876024, 22282.108715651193, 22356.217532386287, 22378.216762413238, 32537.67462325441, 32620.510692340107, 32657.510137347483, 32665.0, 32683.0, 225777.0, 226968.0, 227620.0, 228403.0, 229435.0, 22683.546329072997, 22945.099333113743, 25646.0, 25971.0, 29139.562906555995, 30920.226994325323, 30996.22509437192, 31026.844865775525, 31097.378052438373, 31480.527792083594, 28822.711772882, 28850.567241491815, 28864.278393040342, 29011.7098829009, 29624.259393515335, 28998.42003159967, 29166.0, 29290.121296361143, 30069.3986120272, 30466.695333046388, 28771.136865894056, 28860.855695721388, 28880.0, 29430.705692942796, 29595.112146635634, 24750.504989900463, 25416.745832542176, 28379.57430638501, 28435.573466397607, 28700.125483060354, 22492.775072249067, 22589.096436143027, 22769.544609108056, 22817.543649127256, 22934.0], "value": 15456.721467560046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8065788092774, 406.54263953052816, 419.13448728375903, 431.2173405269436, 431.58352190136515, 18752.718709219374, 18794.15426305816, 19500.122494487747, 19545.120469578884, 19569.51076223095, 18560.81439185611, 18907.810921890778, 19082.713759293623, 19252.13365398557, 19265.422037338867, 5597.44025597441, 5995.430434108753, 6012.939870601282, 6070.089486577004, 6092.360302168275, 5917.674527900964, 6030.396960303957, 6036.607620504675, 6696.0, 6972.407345375624, 6991.89512157318, 6998.0, 7013.964930175342, 7016.964915175443, 7031.683574239171, 6805.387515123638, 7026.0, 7064.576125432491, 7080.362767350963, 7092.326229008288, 6652.268250492442, 6865.382115609619, 6904.378605925491, 6979.267176946449, 7036.331548502884, 22661.206857760066, 22810.65784013241, 23059.884700576556, 23406.297811065695, 23573.528529429488, 2230.353197572702, 2382.1900553811615, 2420.515896820625, 2425.866577338246, 2433.1605596069326, 14196.645083872883, 14199.148051116967, 14445.566633001026, 14510.782338264935, 15034.398624055024, 1852.1202428846325, 1871.4011516314786, 1886.6981282994793, 1893.715942608606, 1899.857510686704, 88218.55890720569, 90744.0, 91158.54420727854, 91300.0, 92873.31956824983, 16072.437464688679, 16399.344026239054, 16477.363621820692, 16676.58308542296, 16734.4142954996, 29000.7099928998, 29061.564076538867, 29113.708862911524, 29132.126036218946, 29316.26709332241, 8553.31573474133, 8630.870536941951, 8762.693305734269, 9023.052579479061, 9157.542122893961, 6999.895001574981, 7022.92977070233, 7089.113860767404, 7260.600666963368, 7263.673134708845, 8926.955365223132, 8937.285017198608, 9013.684521041732, 9103.726888193365, 9319.347645664873, 3439.6216416194197, 3554.680078792869, 3660.103274697716, 3861.7489863158803, 3909.58949310324, 850.9446885952393, 860.1269711242968, 875.7635438431715, 886.1625763653415, 892.3664198419066, 18055.583325002448, 18371.81628183701, 19188.80811191898, 19362.322318718776, 19409.126589303516, 866.4887716247445, 879.384430898361, 884.6770928611139, 927.6892241099173, 927.8144371125802, 9638.90361096394, 9650.71047868565, 10047.397156170508, 10115.797684046278, 10204.642837500653, 470335.0, 479714.0, 487958.0, 489838.0, 507047.0, 88807.0, 91563.08436915679, 91652.54173729089, 91955.0, 92008.0, 1162.4993244139657, 1167.2937872587133, 1197.7963746163173, 1197.9820302695466, 1205.7889869272842, 15859.52421427359, 15991.920040399724, 16119.919400402923, 16157.596060098122, 16645.16774161263, 40762.79618601888, 41407.0, 41498.37752433655, 41948.3707744378, 42533.36199956941, 55027.724861375435, 55421.72289138528, 56711.43288567061, 57269.71365143148, 58349.0, 6618.602883826986, 8607.956960215159, 9673.742413486201, 10114.494275286354, 10659.626913058006, 11741.354225517678, 11782.587609433629, 11915.582954596548, 11924.642260732191, 12256.87743122593, 10638.14894808398, 10686.519106640375, 10718.142548595937, 10908.945455272673, 11123.94438027837, 10684.25210235276, 10729.517171727448, 10755.247132700635, 10762.408067556047, 10794.838077428687, 10514.684559463229, 10610.8408373876, 10804.189685773756, 10853.457327133454, 11102.444877756241, 10676.306040107369, 10688.0, 10702.83945740799, 10707.839382409114, 11099.445027748741, 10761.085307748928, 10847.620333288298, 10928.562857485611, 11121.944390277997, 11233.045191158517], "value": 10067.575816201164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.591711362262, 1450.4343306110618, 1462.5173692681424, 1481.6444053427178, 1524.001778834863, 8326.250637442628, 8484.745457636265, 8953.507557084358, 9301.720948371543, 9344.906550934496, 9049.3665443419, 9463.574139163737, 9484.241260699146, 9489.38319009264, 9492.477913714743, 2002.729631499747, 2035.5013021809677, 2045.754509458867, 2056.845736569756, 2057.783932687069, 1975.5258737902943, 2025.2101680344676, 2043.8671486353414, 2044.2845004248543, 2050.6411378008866, 2012.0945574491464, 2027.3005812994493, 2031.187524990001, 2034.2778313698645, 2048.9077991490417, 1976.21939333963, 1981.5838673878502, 1996.211496458898, 2002.7096071069614, 2003.1186278037617, 1933.4006457997925, 1988.6122206169803, 1992.9601407971904, 2027.9898600507051, 2037.3684157911096, 9674.419534827934, 9716.271279653984, 9725.708228753148, 9728.90271097287, 9736.075072868067, 4779.784909679072, 4918.754062296871, 4940.876478088041, 4960.826371077031, 4973.104841128596, 2651.708312085669, 2842.1757690269797, 2886.5958765772807, 2892.638420197475, 2961.6890226526334, 1050.9054185123375, 1104.5471356743776, 1127.2503784982976, 1143.3197247637643, 1154.5554961339944, 13894.444222231099, 14077.084989475652, 14199.78700319496, 14221.928890355483, 14235.644108897257, 3919.8236079376497, 4198.1393814268, 4223.070924396628, 4239.215745087169, 4279.529251782302, 11775.99904008169, 11788.587399440978, 11800.645980620595, 11840.526378944745, 11842.348670823187, 4880.41435027799, 4887.340209071801, 4919.237518184687, 4996.150654388763, 5004.049230646166, 3824.464574959508, 3896.1428485733095, 4226.598473145046, 4334.9783251083545, 4431.911361772811, 3533.258015816656, 3590.263995880838, 3638.890833275006, 3698.5007024051947, 3706.184639379332, 1030.7938412317567, 1038.9896101039044, 1041.416806588313, 1054.520193312041, 1062.4209805655937, 673.6463356737752, 692.4460431654657, 694.8888177891513, 707.0419581467141, 753.3220101908216, 5597.076482380362, 5597.216389705444, 5658.292713410824, 5702.087665973508, 5906.468417842415, 896.8116695493889, 926.4395041000232, 935.6725146198912, 954.7183580843667, 983.9163671087895, 3649.799261040615, 3705.6294370562728, 3721.3673675475234, 3762.2287431076566, 3831.310364134427, 12100.81848772269, 12422.068344874171, 12501.0, 12515.561955331701, 12525.93737031309, 12263.75472490563, 12276.32480213579, 12391.690207744698, 12397.690057748629, 12404.503819847105, 8364.247217750431, 8697.95651021741, 8700.956495217484, 8706.738797836075, 8963.327750418744, 5545.3622833374675, 5967.49276311501, 6100.420460056288, 6129.417705317987, 6190.9879289230275, 10704.8929510707, 10738.946305268424, 10847.0, 10869.782604348027, 11002.724931876766, 10997.230193886351, 11141.275817071864, 11158.274712143684, 11336.319820810448, 11340.922612351813, 6725.327467253235, 6879.3120687930805, 7747.92252077472, 8204.138565450781, 8385.622646981023, 8672.913270867462, 8782.077881822317, 8844.115588441104, 8856.822863542822, 8856.867146992929, 7726.729564465217, 7887.566183859943, 7892.881606775788, 8007.519548827089, 8110.607370825503, 7781.144074151952, 7787.18234585383, 7838.490498117604, 7844.6077696113825, 7944.880826787487, 6863.6568171590225, 6874.2782007890455, 6907.930920690729, 6909.170899491892, 6972.825679357854, 4995.900081998267, 5038.949610503994, 5039.5968322534845, 5097.235414687826, 5162.045021671003, 4785.425748910014, 4788.6408519361885, 4874.6344024197615, 4920.360353154067, 4924.089043526959], "value": 4498.408224810837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.7990045425243, 370.7627118644068, 379.8879330597474, 381.427858212681, 395.45624765946843, 5325.600579956499, 5400.864978375537, 5454.427285135058, 5458.481444262794, 5532.944670553294, 5234.816781412651, 5256.0, 5313.814016509423, 5335.1197052486295, 5336.9733151334285, 4291.463567054118, 4431.224535706255, 4461.709988850715, 4472.82108715651, 4473.530279320657, 4420.877978570288, 4426.2254105531565, 4449.5327990560845, 4465.37484752135, 4468.486124095722, 4439.2453282941815, 4455.576720211575, 4478.193925093482, 4481.529439408864, 4485.775711214443, 4220.155968806221, 4419.845305414295, 4459.35339375792, 4469.910601787962, 4484.9551504485025, 4097.303458412077, 4103.712740108193, 4112.498937887679, 4130.401091841666, 4141.192467468844, 5225.268462415227, 5228.92156617651, 5268.394134674523, 5274.683518988834, 5281.419043905167, 5048.949510504922, 5188.507091826271, 5220.8694782630355, 5223.3209682741, 5224.660397074216, 5675.6878371689545, 5676.205331253628, 5678.290213723285, 5678.716064196815, 5690.2887139107615, 4537.593346062698, 4541.477730061052, 4546.38623785788, 4557.772111394417, 4564.338170965191, 5844.590878638497, 5920.911186332165, 5924.881502369928, 5969.791057312973, 5991.790287339966, 4680.5085466025575, 4695.7886895089805, 4704.600108990706, 4704.694194877322, 4716.316134160596, 4780.211265141213, 4784.976075119672, 4802.231642937113, 4812.181929071996, 4816.903661926742, 5015.548600625962, 5122.282880396748, 5150.459201783834, 5168.870778230499, 5196.596918831894, 5685.289338832646, 5686.2039314496005, 5702.0, 5709.314882214161, 5714.79998200061, 1652.4629495414038, 1655.2303179021571, 1679.41220572801, 1687.7215259482293, 1688.8009513245488, 1217.73209893825, 1251.960872475843, 1253.2918900821007, 1262.6401475579416, 1266.8099785032318, 4963.032208719337, 4966.230234313615, 4992.276119962585, 5013.548780609763, 5016.573591244712, 5866.8533286667325, 5889.970550147307, 5891.646501209942, 5893.850699113632, 5899.292084949833, 4698.7415692137265, 4930.408350997832, 4947.505249475023, 4950.415866922623, 4990.72551009698, 3071.8310492923106, 3128.9374212515622, 3132.9216769580944, 3139.293658926769, 3141.3874294512807, 5165.690058596496, 5404.297851074462, 5430.022595932691, 5435.456454354533, 5447.210154527651, 5719.370869204384, 6000.559865632217, 6021.189552082262, 6023.6385816851125, 6046.455818976313, 5282.4680842556, 5352.812651557177, 5377.7580008899695, 5412.188171774108, 5442.782288708487, 5807.767689292381, 5843.29880414353, 5889.969255380377, 5892.7642894283745, 5922.911156332744, 5675.404082571271, 5728.0, 5765.596408251382, 5794.768209271582, 5815.680137592473, 5383.488568585978, 5409.215663728816, 5413.377461591967, 5424.783008679608, 5437.972810135924, 4659.953400465952, 4704.3649107370065, 4706.705655944643, 4712.929306060343, 4716.410448693913, 5741.224934633938, 5849.61977471463, 5883.0, 5885.205497257986, 5900.64596124234, 5668.0, 5675.091985282335, 5678.268128220767, 5705.774747848425, 5707.0583353747825, 5496.972515137399, 5593.161025846156, 5669.4047125051275, 5678.46681396029, 5683.175939488834, 5527.723613819373, 5537.529310008695, 5546.861328466821, 5553.111502159797, 5586.664800112007, 5707.4577915098, 5717.514011309086, 5730.0, 5741.598088133791, 5750.166225897305, 5334.786608535615, 5540.390557038803, 5572.0527510324155, 5573.498385145356, 5592.664440133605], "value": 4450.637698346344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.337365947223, 679.9320067993201, 681.366329313738, 694.7568351077124, 706.1420374245291, 12772.361381930901, 13486.662833429169, 13490.25803580805, 13516.594502164926, 13592.592222233336, 12701.428435720392, 12739.808902866464, 12894.80657790134, 12900.80648790269, 13063.0, 795.6220795122329, 824.6618886256636, 829.7925518620345, 831.683960095163, 835.3442547600135, 852.7356519478982, 856.4604299291437, 859.3554833874595, 859.7420773767844, 861.0313397427893, 882.9028806831243, 885.2254277507182, 886.171429713217, 886.4592598514932, 888.2183678363032, 872.358816270041, 873.1094283830521, 875.8335916175906, 877.0659247900965, 878.1525827576387, 638.9872202555923, 640.5388120553195, 646.0309535696455, 646.3439608797074, 646.9417752402306, 14214.85785142156, 14402.0, 14423.855761442355, 14429.71140577193, 14555.490557830424, 13334.133281336683, 13411.664708382272, 14108.858911410856, 14158.433662653482, 14320.928395357956, 10325.586976521005, 10479.181320150974, 10602.0, 10854.131669466502, 10997.835032474439, 3248.586864713857, 3253.186703324169, 3281.1797050737314, 3288.2765791525826, 3288.6546912574313, 61894.38105618976, 61907.85074894969, 62164.68917655428, 62799.0, 62918.0, 10474.895251047545, 10523.21075919309, 10554.10290125348, 10705.357678539312, 11196.104311655048, 21387.8930605346, 21536.892315538636, 21548.461288467915, 21652.891735541223, 21892.45268868259, 6329.525285603599, 6428.067930150102, 6500.122483464766, 6527.314631963671, 6529.314421985718, 3458.360203362386, 3464.237867669159, 3538.433850583894, 3552.8223588820456, 3569.839357228931, 2830.674472435655, 2836.4894319022774, 2879.7264259895696, 2895.6525216974096, 2898.3044069423186, 476.5877515948749, 483.66868694944077, 484.7406637448948, 486.1274013146411, 489.56428778387266, 607.1621162795315, 629.2449061126575, 634.4607083978582, 642.2549842183046, 658.7035833874776, 8455.0, 8905.376623636414, 9202.171804537624, 9252.907470925205, 9318.534073296309, 586.1354502109355, 607.9996810493516, 614.3579958942915, 617.7992152550349, 627.5105417774143, 4142.378643203483, 4260.026290334557, 4281.250781113355, 4284.228838809045, 4291.506476755213, 47957.52042479531, 48737.268940965914, 48909.0, 55537.44462555404, 59702.10446843301, 54461.0, 54738.0, 55370.72314638401, 56092.0, 56513.0, 47164.7641761789, 47695.99999999931, 48588.0, 49069.0, 50095.24857127146, 8038.236367545074, 8338.499690018618, 8430.45202061864, 8438.919794274923, 8524.659013639384, 34412.82793586116, 34771.478427824106, 34840.0, 35251.118722031126, 35251.47122793109, 40058.599414006654, 40825.38761918633, 40850.59149408587, 41758.791206043774, 41935.0, 10428.478576071015, 10576.947115264375, 10670.0930420912, 10675.092617127631, 10925.125989920945, 10633.361998280128, 10671.89328106709, 10769.461526923778, 11446.255993360404, 11457.770844582896, 10584.735381615521, 10730.0, 10801.621943231949, 10988.340699558052, 11138.721531961766, 10480.68557943263, 10651.89348106509, 10679.19906007037, 10946.507407166537, 10958.178136639943, 10735.785284294427, 10757.085647719718, 10762.813940292786, 10773.107330089319, 10941.124710023338, 8803.515806630698, 8811.691590794291, 8846.248068914214, 8913.153250441197, 9104.362694611315, 8352.019888129273, 8380.287675547403, 8737.91262087371, 9046.909530904606, 9132.132447417485], "value": 6221.041535646214, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 117.0, 119.0, 120.0, 119.0, 121.0, 118.0, 119.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 127.0, 182.0, 129.0, 127.0, 127.0, 126.0, 152.0, 129.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 170.0, 173.0, 168.0, 168.0, 163.0, 165.0, 166.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 120.0, 78.0, 76.0, 87.0, 76.0, 96.0, 79.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 104.0, 85.0, 85.0, 85.0, 101.0, 86.0, 85.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 118.0, 115.0, 114.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 151.0, 152.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 69.0, 69.0, 67.0, 68.0, 71.0, 68.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 83.0, 81.0, 83.0, 82.0, 84.0, 85.0, 83.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 133.0, 141.0, 136.0, 146.0, 133.0, 149.0, 180.0, 138.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 207.0, 186.0, 203.0, 199.0, 195.0, 194.0, 219.0, 187.0, 193.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 75.0, 82.0, 75.0, 70.0, 70.0, 75.0, 70.0], "value": 73.4, "unit": "score"}]}]} 09:03:01 INFO - Return code: 0 09:03:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:01 ERROR - # TBPL SUCCESS # 09:03:01 INFO - Running post-action listener: _resource_record_post_action 09:03:01 INFO - [mozharness: 2017-03-16 16:03:01.635844Z] Finished run-tests step (success) 09:03:01 INFO - Running post-run listener: _resource_record_post_run 09:03:01 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361091072; Read time: 12; Write time: 200244 09:03:01 INFO - TinderboxPrint: CPU usage
13.3% 09:03:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:03:01 INFO - TinderboxPrint: I/O write bytes / time
361,091,072 / 200,244 09:03:01 INFO - TinderboxPrint: CPU idle
8,295.9 (86.7%) 09:03:01 INFO - TinderboxPrint: CPU user
1,217.7 (12.7%) 09:03:01 INFO - TinderboxPrint: Swap in / out
0 / 0 09:03:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105672704; Read time: 0; Write time: 85184 09:03:01 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255418368; Read time: 12; Write time: 115060 09:03:02 INFO - Running post-run listener: _upload_blobber_files 09:03:02 INFO - Blob upload gear active. 09:03:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:02 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 09:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:03 INFO - (blobuploader) - INFO - Done attempting. 09:03:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:04 INFO - (blobuploader) - INFO - Done attempting. 09:03:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:03:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:03:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:05 INFO - (blobuploader) - INFO - Done attempting. 09:03:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:09 INFO - (blobuploader) - INFO - Done attempting. 09:03:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:09 INFO - Return code: 0 09:03:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54347e863744f6271a1db17b6363de9aabbabcb1e5a57d0bdbd14e8d0ae4ccababf1a783ac8875f97c1663416abd83607d0900bb73f1a6fb25493708ea66b650", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdf24303841929f236e9e6e5e4686d69da46cadea4fba826894df2d546e340bc94c1acb808796d538bff5c695c84281cac39e7ed17b138e5c56c209e4b4e562b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8cf6698261e257b4da896217f87ff75d254457cd82fb20ec1589ad85401088c687d867af597011b9f0f3cd0600b91a6b58995d7b841bb6837b5c780668c5d0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa14dfbf74ae348b5f0b233c2f62619d9be83c5bb4bd39e50c26000258f745582360b6987c62e67cd3a0e241e46ed3b096585986cd2bb040f2c5419ca156d9ed"} 09:03:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:09 INFO - Contents: 09:03:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54347e863744f6271a1db17b6363de9aabbabcb1e5a57d0bdbd14e8d0ae4ccababf1a783ac8875f97c1663416abd83607d0900bb73f1a6fb25493708ea66b650", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdf24303841929f236e9e6e5e4686d69da46cadea4fba826894df2d546e340bc94c1acb808796d538bff5c695c84281cac39e7ed17b138e5c56c209e4b4e562b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8cf6698261e257b4da896217f87ff75d254457cd82fb20ec1589ad85401088c687d867af597011b9f0f3cd0600b91a6b58995d7b841bb6837b5c780668c5d0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa14dfbf74ae348b5f0b233c2f62619d9be83c5bb4bd39e50c26000258f745582360b6987c62e67cd3a0e241e46ed3b096585986cd2bb040f2c5419ca156d9ed"} 09:03:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:09 INFO - Copying logs to upload dir... 09:03:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.782898 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-16 09:03:08.860910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 09:03:08.864520) ========= 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=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54347e863744f6271a1db17b6363de9aabbabcb1e5a57d0bdbd14e8d0ae4ccababf1a783ac8875f97c1663416abd83607d0900bb73f1a6fb25493708ea66b650", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdf24303841929f236e9e6e5e4686d69da46cadea4fba826894df2d546e340bc94c1acb808796d538bff5c695c84281cac39e7ed17b138e5c56c209e4b4e562b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8cf6698261e257b4da896217f87ff75d254457cd82fb20ec1589ad85401088c687d867af597011b9f0f3cd0600b91a6b58995d7b841bb6837b5c780668c5d0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa14dfbf74ae348b5f0b233c2f62619d9be83c5bb4bd39e50c26000258f745582360b6987c62e67cd3a0e241e46ed3b096585986cd2bb040f2c5419ca156d9ed"} build_url:https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/DwPl77w9S7W-tjgoe1S4JQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54347e863744f6271a1db17b6363de9aabbabcb1e5a57d0bdbd14e8d0ae4ccababf1a783ac8875f97c1663416abd83607d0900bb73f1a6fb25493708ea66b650", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cdf24303841929f236e9e6e5e4686d69da46cadea4fba826894df2d546e340bc94c1acb808796d538bff5c695c84281cac39e7ed17b138e5c56c209e4b4e562b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8cf6698261e257b4da896217f87ff75d254457cd82fb20ec1589ad85401088c687d867af597011b9f0f3cd0600b91a6b58995d7b841bb6837b5c780668c5d0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa14dfbf74ae348b5f0b233c2f62619d9be83c5bb4bd39e50c26000258f745582360b6987c62e67cd3a0e241e46ed3b096585986cd2bb040f2c5419ca156d9ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 09:03:08.894292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 09:03:08.895031) ========= 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=0333a256a5e4f052382dd180000001b1-1489678861.812534-1026565644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 09:03:08.977297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 09:03:08.977648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 09:03:08.977979) ========= ========= Total master_lag: 0.20 =========