builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-078 starttime: 1490197040.04 results: success (0) revision: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.037457) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.037966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.038255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.049894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.050153) ========= 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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 08:37:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 555K=0.02s 2017-03-22 08:37:21 (555 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.277647 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.339254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.339562) ========= 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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019962 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:20.388806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:37:20.389112) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 --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 e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 --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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 08:37:21,206 truncating revision to first 12 chars 2017-03-22 08:37:21,206 Setting DEBUG logging. 2017-03-22 08:37:21,206 attempt 1/10 2017-03-22 08:37:21,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e03e0c60462c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:37:21,919 unpacking tar archive at: mozilla-central-e03e0c60462c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.054599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:37:21.457014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:21.457349) ========= script_repo_revision: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:21.457701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:21.457975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:37:21.466885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-22 08:37:21.467146) ========= /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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:37:22 INFO - MultiFileLogger online at 20170322 08:37:22 in /builds/slave/test 08:37:22 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:37:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:22 INFO - {'append_to_log': False, 08:37:22 INFO - 'base_work_dir': '/builds/slave/test', 08:37:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:37:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:22 INFO - 'branch': 'Firefox-Non-PGO', 08:37:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:22 INFO - 'config_files': ('talos/linux_config.py',), 08:37:22 INFO - 'default_actions': ('clobber', 08:37:22 INFO - 'read-buildbot-config', 08:37:22 INFO - 'download-and-extract', 08:37:22 INFO - 'populate-webroot', 08:37:22 INFO - 'create-virtualenv', 08:37:22 INFO - 'install', 08:37:22 INFO - 'run-tests'), 08:37:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:22 INFO - 'download_minidump_stackwalk': True, 08:37:22 INFO - 'download_symbols': 'ondemand', 08:37:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:22 INFO - 'gecko_profile': False, 08:37:22 INFO - 'gecko_profile_interval': 0, 08:37:22 INFO - 'installer_path': 'installer.exe', 08:37:22 INFO - 'log_level': 'info', 08:37:22 INFO - 'log_name': 'talos', 08:37:22 INFO - 'log_to_console': True, 08:37:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:37:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:37:22 INFO - 'opt_config_files': (), 08:37:22 INFO - 'pip_index': False, 08:37:22 INFO - 'suite': 'dromaeojs-e10s', 08:37:22 INFO - 'system_bits': '32', 08:37:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:22 INFO - 'title': 'talos-linux64-ix-078', 08:37:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:22 INFO - 'use_talos_json': True, 08:37:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:22 INFO - 'work_dir': 'build'} 08:37:22 INFO - [mozharness: 2017-03-22 15:37:22.385581Z] Running clobber step. 08:37:22 INFO - Running pre-action listener: _resource_record_pre_action 08:37:22 INFO - Running main action method: clobber 08:37:22 INFO - rmtree: /builds/slave/test/build 08:37:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:23 INFO - Running post-action listener: _resource_record_post_action 08:37:23 INFO - [mozharness: 2017-03-22 15:37:23.324984Z] Finished clobber step (success) 08:37:23 INFO - [mozharness: 2017-03-22 15:37:23.325085Z] Running read-buildbot-config step. 08:37:23 INFO - Running pre-action listener: _resource_record_pre_action 08:37:23 INFO - Running main action method: read_buildbot_config 08:37:23 INFO - Using buildbot properties: 08:37:23 INFO - { 08:37:23 INFO - "project": "", 08:37:23 INFO - "product": "firefox", 08:37:23 INFO - "who": "cbook@mozilla.com", 08:37:23 INFO - "installer_path": "public/build/target.tar.bz2", 08:37:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:37:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:37:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:37:23 INFO - "stage_platform": "linux64", 08:37:23 INFO - "basedir": "/builds/slave/test", 08:37:23 INFO - "buildnumber": 730, 08:37:23 INFO - "platform": "ubuntu64_hw", 08:37:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:37:23 INFO - "slavebuilddir": "test", 08:37:23 INFO - "taskId": "dUx6fwcRSNuVp-bBeZOmUA", 08:37:23 INFO - "branch": "mozilla-central", 08:37:23 INFO - "script_repo_revision": "production", 08:37:23 INFO - "revision": "e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9", 08:37:23 INFO - "slavename": "talos-linux64-ix-078", 08:37:23 INFO - "repo_path": "mozilla-central" 08:37:23 INFO - } 08:37:23 INFO - Finding installer, test and symbols from parent task. 08:37:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dUx6fwcRSNuVp-bBeZOmUA'}, attempt #1 08:37:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dUx6fwcRSNuVp-bBeZOmUA'}, attempt #1 08:37:24 INFO - Task dependencies: JVct9Vz3RZCSFfI6nhmynA 08:37:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA'}, attempt #1 08:37:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 08:37:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/test_packages.json 08:37:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.crashreporter-symbols.zip 08:37:24 INFO - Running post-action listener: _resource_record_post_action 08:37:24 INFO - [mozharness: 2017-03-22 15:37:24.767247Z] Finished read-buildbot-config step (success) 08:37:24 INFO - [mozharness: 2017-03-22 15:37:24.767464Z] Running download-and-extract step. 08:37:24 INFO - Running pre-action listener: _resource_record_pre_action 08:37:24 INFO - Running main action method: download_and_extract 08:37:24 INFO - mkdir: /builds/slave/test/build/tests 08:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:24 INFO - trying https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.test_packages.json 08:37:24 INFO - Downloading https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:37:25 INFO - Downloaded 986 bytes. 08:37:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:37:25 INFO - Using the following test package requirements: 08:37:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:37:25 INFO - u'common': [u'target.common.tests.zip'], 08:37:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:37:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:37:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:37:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:37:25 INFO - u'mozbase': [u'target.common.tests.zip'], 08:37:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:37:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:37:25 INFO - u'web-platform': [u'target.common.tests.zip', 08:37:25 INFO - u'target.web-platform.tests.zip'], 08:37:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:37:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:37:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip 08:37:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:37:25 INFO - Fetch https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip into memory 08:37:26 INFO - Expected file size: 58119324 08:37:26 INFO - Obtained file size: 58119324 08:37:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:37:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip 08:37:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:37:36 INFO - Fetch https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.common.tests.zip into memory 08:37:37 INFO - Expected file size: 58119324 08:37:37 INFO - Obtained file size: 58119324 08:37:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.talos.tests.zip 08:37:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:37:48 INFO - Fetch https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.talos.tests.zip into memory 08:37:48 INFO - Expected file size: 14404171 08:37:48 INFO - Obtained file size: 14404171 08:37:49 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:37:49 INFO - trying https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 08:37:49 INFO - Downloading https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:37:50 INFO - Downloaded 61926344 bytes. 08:37:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 08:37:50 INFO - mkdir: /builds/slave/test/properties 08:37:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:50 INFO - Contents: 08:37:50 INFO - build_url:https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 08:37:50 INFO - Running post-action listener: _resource_record_post_action 08:37:50 INFO - Running post-action listener: set_extra_try_arguments 08:37:50 INFO - [mozharness: 2017-03-22 15:37:50.230908Z] Finished download-and-extract step (success) 08:37:50 INFO - [mozharness: 2017-03-22 15:37:50.231005Z] Running populate-webroot step. 08:37:50 INFO - Running pre-action listener: _resource_record_pre_action 08:37:50 INFO - Running main action method: populate_webroot 08:37:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:50 INFO - '--tppagecycles', 08:37:50 INFO - '7'], 08:37:50 INFO - 'tests': ['tsvgm']}}, 08:37:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:37:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['damp', 'tps']}, 08:37:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'tests': ['damp', 'tps']}, 08:37:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['dromaeo_dom']}, 08:37:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['basic_compositor_video']}, 08:37:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:37:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['a11yr', 08:37:50 INFO - 'ts_paint', 08:37:50 INFO - 'tpaint', 08:37:50 INFO - 'sessionrestore', 08:37:50 INFO - 'sessionrestore_no_auto_restore', 08:37:50 INFO - 'tabpaint']}, 08:37:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['tsvgx', 08:37:50 INFO - 'tsvgr_opacity', 08:37:50 INFO - 'tart', 08:37:50 INFO - 'tscrollx', 08:37:50 INFO - 'cart', 08:37:50 INFO - 'tsvg_static']}, 08:37:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:50 INFO - 'tsvgr_opacity', 08:37:50 INFO - 'tart', 08:37:50 INFO - 'tscrollx', 08:37:50 INFO - 'cart', 08:37:50 INFO - 'tsvg_static']}, 08:37:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'talos_options': ['--disable-e10s'], 08:37:50 INFO - 'tests': ['tp5o']}, 08:37:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:37:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'talos_options': ['--disable-e10s', 08:37:50 INFO - '--xperf_path', 08:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:50 INFO - 'tests': ['tp5n']}, 08:37:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:37:50 INFO - 'talos_options': ['--xperf_path', 08:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:50 INFO - 'tests': ['tp5n']}}, 08:37:50 INFO - 'talos.zip': {'path': '', 08:37:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:50 INFO - Running post-action listener: _resource_record_post_action 08:37:50 INFO - [mozharness: 2017-03-22 15:37:50.244145Z] Finished populate-webroot step (success) 08:37:50 INFO - [mozharness: 2017-03-22 15:37:50.244235Z] Running create-virtualenv step. 08:37:50 INFO - Running pre-action listener: _resource_record_pre_action 08:37:50 INFO - Running main action method: create_virtualenv 08:37:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:50 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:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:50 INFO - Using real prefix '/usr' 08:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:52 INFO - Installing pip.................done. 08:37:52 INFO - Return code: 0 08:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:37:53 INFO - Reading from file tmpfile_stdout 08:37:53 INFO - Output received: 08:37:53 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:37:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:37:53 INFO - Using env: {'DISPLAY': ':0', 08:37:53 INFO - 'HOME': '/home/cltbld', 08:37:53 INFO - 'LANG': 'en_US.UTF-8', 08:37:53 INFO - 'LANGUAGE': 'en_US:en', 08:37:53 INFO - 'LOGNAME': 'cltbld', 08:37:53 INFO - 'MAIL': '/var/mail/cltbld', 08:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:53 INFO - 'MOZ_NO_REMOTE': '1', 08:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:53 INFO - 'NO_EM_RESTART': '1', 08:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:53 INFO - 'PWD': '/builds/slave/test', 08:37:53 INFO - 'SHELL': '/bin/bash', 08:37:53 INFO - 'SHLVL': '1', 08:37:53 INFO - 'TERM': 'linux', 08:37:53 INFO - 'TMOUT': '86400', 08:37:53 INFO - 'USER': 'cltbld', 08:37:53 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:53 INFO - '_': '/tools/buildbot/bin/python'} 08:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:53 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:37:53 INFO - Cleaning up... 08:37:53 INFO - Return code: 0 08:37:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:37:53 INFO - Using env: {'DISPLAY': ':0', 08:37:53 INFO - 'HOME': '/home/cltbld', 08:37:53 INFO - 'LANG': 'en_US.UTF-8', 08:37:53 INFO - 'LANGUAGE': 'en_US:en', 08:37:53 INFO - 'LOGNAME': 'cltbld', 08:37:53 INFO - 'MAIL': '/var/mail/cltbld', 08:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:53 INFO - 'MOZ_NO_REMOTE': '1', 08:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:53 INFO - 'NO_EM_RESTART': '1', 08:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:53 INFO - 'PWD': '/builds/slave/test', 08:37:53 INFO - 'SHELL': '/bin/bash', 08:37:53 INFO - 'SHLVL': '1', 08:37:53 INFO - 'TERM': 'linux', 08:37:53 INFO - 'TMOUT': '86400', 08:37:53 INFO - 'USER': 'cltbld', 08:37:53 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:53 INFO - '_': '/tools/buildbot/bin/python'} 08:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:53 INFO - Downloading/unpacking psutil>=3.1.1 08:37: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:37: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:37: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:37: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:37: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:37: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:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:55 INFO - Installing collected packages: psutil 08:37:55 INFO - Running setup.py install for psutil 08:37:55 INFO - building 'psutil._psutil_linux' extension 08:37:55 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:37:55 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:37:55 INFO - building 'psutil._psutil_posix' extension 08:37:55 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:37:55 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:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:56 INFO - Successfully installed psutil 08:37:56 INFO - Cleaning up... 08:37:56 INFO - Return code: 0 08:37:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:56 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:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:56 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:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:56 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:37:56 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:37:56 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:37:56 INFO - Using env: {'DISPLAY': ':0', 08:37:56 INFO - 'HOME': '/home/cltbld', 08:37:56 INFO - 'LANG': 'en_US.UTF-8', 08:37:56 INFO - 'LANGUAGE': 'en_US:en', 08:37:56 INFO - 'LOGNAME': 'cltbld', 08:37:56 INFO - 'MAIL': '/var/mail/cltbld', 08:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:56 INFO - 'MOZ_NO_REMOTE': '1', 08:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:56 INFO - 'NO_EM_RESTART': '1', 08:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:56 INFO - 'PWD': '/builds/slave/test', 08:37:56 INFO - 'SHELL': '/bin/bash', 08:37:56 INFO - 'SHLVL': '1', 08:37:56 INFO - 'TERM': 'linux', 08:37:56 INFO - 'TMOUT': '86400', 08:37:56 INFO - 'USER': 'cltbld', 08:37:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:56 INFO - '_': '/tools/buildbot/bin/python'} 08:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:58 INFO - Installing collected packages: mozsystemmonitor 08:37:58 INFO - Running setup.py install for mozsystemmonitor 08:37:58 INFO - Successfully installed mozsystemmonitor 08:37:58 INFO - Cleaning up... 08:37:58 INFO - Return code: 0 08:37:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:58 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:37:58 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:37:58 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:37:58 INFO - Using env: {'DISPLAY': ':0', 08:37:58 INFO - 'HOME': '/home/cltbld', 08:37:58 INFO - 'LANG': 'en_US.UTF-8', 08:37:58 INFO - 'LANGUAGE': 'en_US:en', 08:37:58 INFO - 'LOGNAME': 'cltbld', 08:37:58 INFO - 'MAIL': '/var/mail/cltbld', 08:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:58 INFO - 'MOZ_NO_REMOTE': '1', 08:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:58 INFO - 'NO_EM_RESTART': '1', 08:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:58 INFO - 'PWD': '/builds/slave/test', 08:37:58 INFO - 'SHELL': '/bin/bash', 08:37:58 INFO - 'SHLVL': '1', 08:37:58 INFO - 'TERM': 'linux', 08:37:58 INFO - 'TMOUT': '86400', 08:37:58 INFO - 'USER': 'cltbld', 08:37:58 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:58 INFO - '_': '/tools/buildbot/bin/python'} 08:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:37: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:37: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:37: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:37: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:37: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:37: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:38:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:38:00 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:38:00 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:38:00 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:38:00 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:38:00 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:38:00 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:38:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:01 INFO - warning: no files found matching '*.txt' 08:38:01 INFO - no previously-included directories found matching 'build' 08:38:01 INFO - no previously-included directories found matching 'dist' 08:38:01 INFO - no previously-included directories found matching '.git*' 08:38:01 INFO - Installing collected packages: jsonschema, functools32 08:38:01 INFO - Running setup.py install for functools32 08:38:01 INFO - warning: no files found matching '*.txt' 08:38:01 INFO - no previously-included directories found matching 'build' 08:38:01 INFO - no previously-included directories found matching 'dist' 08:38:01 INFO - no previously-included directories found matching '.git*' 08:38:01 INFO - Successfully installed jsonschema functools32 08:38:01 INFO - Cleaning up... 08:38:01 INFO - Return code: 0 08:38:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:38: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:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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', '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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:38: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 functools32==3.2.3-2 08:38:01 INFO - Using env: {'DISPLAY': ':0', 08:38:01 INFO - 'HOME': '/home/cltbld', 08:38:01 INFO - 'LANG': 'en_US.UTF-8', 08:38:01 INFO - 'LANGUAGE': 'en_US:en', 08:38:01 INFO - 'LOGNAME': 'cltbld', 08:38:01 INFO - 'MAIL': '/var/mail/cltbld', 08:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:01 INFO - 'MOZ_NO_REMOTE': '1', 08:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:01 INFO - 'NO_EM_RESTART': '1', 08:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:01 INFO - 'PWD': '/builds/slave/test', 08:38:01 INFO - 'SHELL': '/bin/bash', 08:38:01 INFO - 'SHLVL': '1', 08:38:01 INFO - 'TERM': 'linux', 08:38:01 INFO - 'TMOUT': '86400', 08:38:01 INFO - 'USER': 'cltbld', 08:38:01 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:01 INFO - '_': '/tools/buildbot/bin/python'} 08:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:38:01 INFO - Cleaning up... 08:38:01 INFO - Return code: 0 08:38:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38: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:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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', '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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:38: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 blobuploader==1.2.4 08:38:01 INFO - Using env: {'DISPLAY': ':0', 08:38:01 INFO - 'HOME': '/home/cltbld', 08:38:01 INFO - 'LANG': 'en_US.UTF-8', 08:38:01 INFO - 'LANGUAGE': 'en_US:en', 08:38:01 INFO - 'LOGNAME': 'cltbld', 08:38:01 INFO - 'MAIL': '/var/mail/cltbld', 08:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:01 INFO - 'MOZ_NO_REMOTE': '1', 08:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:01 INFO - 'NO_EM_RESTART': '1', 08:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:01 INFO - 'PWD': '/builds/slave/test', 08:38:01 INFO - 'SHELL': '/bin/bash', 08:38:01 INFO - 'SHLVL': '1', 08:38:01 INFO - 'TERM': 'linux', 08:38:01 INFO - 'TMOUT': '86400', 08:38:01 INFO - 'USER': 'cltbld', 08:38:01 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:01 INFO - '_': '/tools/buildbot/bin/python'} 08:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:03 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:38:03 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:38:03 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:38:03 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:38:03 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:38:03 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:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:04 INFO - Downloading docopt-0.6.1.tar.gz 08:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:04 INFO - Running setup.py install for blobuploader 08:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:04 INFO - Running setup.py install for requests 08:38:04 INFO - Running setup.py install for docopt 08:38:05 INFO - Successfully installed blobuploader requests docopt 08:38:05 INFO - Cleaning up... 08:38:05 INFO - Return code: 0 08:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:05 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:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 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:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:05 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38:05 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:38:05 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:38:05 INFO - Using env: {'DISPLAY': ':0', 08:38:05 INFO - 'HOME': '/home/cltbld', 08:38:05 INFO - 'LANG': 'en_US.UTF-8', 08:38:05 INFO - 'LANGUAGE': 'en_US:en', 08:38:05 INFO - 'LOGNAME': 'cltbld', 08:38:05 INFO - 'MAIL': '/var/mail/cltbld', 08:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:05 INFO - 'MOZ_NO_REMOTE': '1', 08:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:05 INFO - 'NO_EM_RESTART': '1', 08:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:05 INFO - 'PWD': '/builds/slave/test', 08:38:05 INFO - 'SHELL': '/bin/bash', 08:38:05 INFO - 'SHLVL': '1', 08:38:05 INFO - 'TERM': 'linux', 08:38:05 INFO - 'TMOUT': '86400', 08:38:05 INFO - 'USER': 'cltbld', 08:38:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:05 INFO - '_': '/tools/buildbot/bin/python'} 08:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:05 INFO - Running setup.py (path:/tmp/pip-h3ALeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:05 INFO - Running setup.py (path:/tmp/pip-yuSpYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:05 INFO - Running setup.py (path:/tmp/pip-aHSCVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:05 INFO - Running setup.py (path:/tmp/pip-3qyjdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:05 INFO - Running setup.py (path:/tmp/pip-Op4SyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:05 INFO - Running setup.py (path:/tmp/pip-HYHtL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:05 INFO - Running setup.py (path:/tmp/pip-T7A7Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:05 INFO - Running setup.py (path:/tmp/pip-bWIymf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:05 INFO - Running setup.py (path:/tmp/pip-D3h76K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:06 INFO - Running setup.py (path:/tmp/pip-XHJKu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:06 INFO - Running setup.py (path:/tmp/pip-hGOghi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:06 INFO - Running setup.py (path:/tmp/pip-RKLkft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:06 INFO - Running setup.py (path:/tmp/pip-iUxWF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:06 INFO - Running setup.py (path:/tmp/pip-zKA10k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:06 INFO - Running setup.py (path:/tmp/pip-cvNGAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:06 INFO - Running setup.py (path:/tmp/pip-qDInou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:06 INFO - Running setup.py (path:/tmp/pip-hQbfUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:06 INFO - Running setup.py install for manifestparser 08:38:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:06 INFO - Running setup.py install for mozcrash 08:38:06 INFO - Running setup.py install for mozdebug 08:38:06 INFO - Running setup.py install for mozdevice 08:38:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:06 INFO - Running setup.py install for mozfile 08:38:07 INFO - Running setup.py install for mozhttpd 08:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozinfo 08:38:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozInstall 08:38:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozleak 08:38:07 INFO - Running setup.py install for mozlog 08:38:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for moznetwork 08:38:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozprocess 08:38:07 INFO - Running setup.py install for mozprofile 08:38:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:07 INFO - Running setup.py install for mozrunner 08:38:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Running setup.py install for mozscreenshot 08:38:08 INFO - Running setup.py install for moztest 08:38:08 INFO - Running setup.py install for mozversion 08:38:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:08 INFO - Cleaning up... 08:38:08 INFO - Return code: 0 08:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:08 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:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 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:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:08 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38:08 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:38:08 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:38:08 INFO - Using env: {'DISPLAY': ':0', 08:38:08 INFO - 'HOME': '/home/cltbld', 08:38:08 INFO - 'LANG': 'en_US.UTF-8', 08:38:08 INFO - 'LANGUAGE': 'en_US:en', 08:38:08 INFO - 'LOGNAME': 'cltbld', 08:38:08 INFO - 'MAIL': '/var/mail/cltbld', 08:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:08 INFO - 'MOZ_NO_REMOTE': '1', 08:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:08 INFO - 'NO_EM_RESTART': '1', 08:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:08 INFO - 'PWD': '/builds/slave/test', 08:38:08 INFO - 'SHELL': '/bin/bash', 08:38:08 INFO - 'SHLVL': '1', 08:38:08 INFO - 'TERM': 'linux', 08:38:08 INFO - 'TMOUT': '86400', 08:38:08 INFO - 'USER': 'cltbld', 08:38:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:08 INFO - '_': '/tools/buildbot/bin/python'} 08:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:08 INFO - Running setup.py (path:/tmp/pip-wmw_oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:08 INFO - Running setup.py (path:/tmp/pip-MCrDjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:08 INFO - Running setup.py (path:/tmp/pip-RNLbrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:08 INFO - Running setup.py (path:/tmp/pip-o927Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:08 INFO - Running setup.py (path:/tmp/pip-1kGpwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:08 INFO - Running setup.py (path:/tmp/pip-kDL7H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:09 INFO - Running setup.py (path:/tmp/pip-CIqLFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:09 INFO - Running setup.py (path:/tmp/pip-i72k2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:09 INFO - Running setup.py (path:/tmp/pip-u7OPIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:09 INFO - Running setup.py (path:/tmp/pip-KUx5Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:09 INFO - Running setup.py (path:/tmp/pip-cllLnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:09 INFO - Running setup.py (path:/tmp/pip-omyHs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:09 INFO - Running setup.py (path:/tmp/pip-tAjZrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:09 INFO - Running setup.py (path:/tmp/pip-m6WdRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:09 INFO - Running setup.py (path:/tmp/pip-GWlycp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:09 INFO - Running setup.py (path:/tmp/pip-6xmqjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:09 INFO - Running setup.py (path:/tmp/pip-B_HTWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:11 INFO - Downloading blessings-1.6.tar.gz 08:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:11 INFO - Installing collected packages: blessings 08:38:11 INFO - Running setup.py install for blessings 08:38:12 INFO - Successfully installed blessings 08:38:12 INFO - Cleaning up... 08:38:12 INFO - Return code: 0 08:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:12 INFO - Reading from file tmpfile_stdout 08:38:12 INFO - Current package versions: 08:38:12 INFO - argparse == 1.2.1 08:38:12 INFO - blessings == 1.6 08:38:12 INFO - blobuploader == 1.2.4 08:38:12 INFO - docopt == 0.6.1 08:38:12 INFO - functools32 == 3.2.3-2 08:38:12 INFO - jsonschema == 2.5.1 08:38:12 INFO - manifestparser == 1.1 08:38:12 INFO - mozInstall == 1.12 08:38:12 INFO - mozcrash == 1.0 08:38:12 INFO - mozdebug == 0.1 08:38:12 INFO - mozdevice == 0.49 08:38:12 INFO - mozfile == 1.2 08:38:12 INFO - mozhttpd == 0.7 08:38:12 INFO - mozinfo == 0.9 08:38:12 INFO - mozleak == 0.1 08:38:12 INFO - mozlog == 3.4 08:38:12 INFO - moznetwork == 0.27 08:38:12 INFO - mozprocess == 0.25 08:38:12 INFO - mozprofile == 0.28 08:38:12 INFO - mozrunner == 6.13 08:38:12 INFO - mozscreenshot == 0.1 08:38:12 INFO - mozsystemmonitor == 0.3 08:38:12 INFO - moztest == 0.8 08:38:12 INFO - mozversion == 1.4 08:38:12 INFO - psutil == 3.1.1 08:38:12 INFO - requests == 1.2.3 08:38:12 INFO - wsgiref == 0.1.2 08:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38:12 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:38:12 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:38:12 INFO - Using env: {'DISPLAY': ':0', 08:38:12 INFO - 'HOME': '/home/cltbld', 08:38:12 INFO - 'LANG': 'en_US.UTF-8', 08:38:12 INFO - 'LANGUAGE': 'en_US:en', 08:38:12 INFO - 'LOGNAME': 'cltbld', 08:38:12 INFO - 'MAIL': '/var/mail/cltbld', 08:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:12 INFO - 'MOZ_NO_REMOTE': '1', 08:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:12 INFO - 'NO_EM_RESTART': '1', 08:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:12 INFO - 'PWD': '/builds/slave/test', 08:38:12 INFO - 'SHELL': '/bin/bash', 08:38:12 INFO - 'SHLVL': '1', 08:38:12 INFO - 'TERM': 'linux', 08:38:12 INFO - 'TMOUT': '86400', 08:38:12 INFO - 'USER': 'cltbld', 08:38:12 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:12 INFO - '_': '/tools/buildbot/bin/python'} 08:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 INFO - Cleaning up... 08:38:12 INFO - Return code: 0 08:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, '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': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', '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:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:38:12 INFO - Using env: {'DISPLAY': ':0', 08:38:12 INFO - 'HOME': '/home/cltbld', 08:38:12 INFO - 'LANG': 'en_US.UTF-8', 08:38:12 INFO - 'LANGUAGE': 'en_US:en', 08:38:12 INFO - 'LOGNAME': 'cltbld', 08:38:12 INFO - 'MAIL': '/var/mail/cltbld', 08:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:12 INFO - 'MOZ_NO_REMOTE': '1', 08:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:12 INFO - 'NO_EM_RESTART': '1', 08:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:12 INFO - 'PWD': '/builds/slave/test', 08:38:12 INFO - 'SHELL': '/bin/bash', 08:38:12 INFO - 'SHLVL': '1', 08:38:12 INFO - 'TERM': 'linux', 08:38:12 INFO - 'TMOUT': '86400', 08:38:12 INFO - 'USER': 'cltbld', 08:38:12 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:12 INFO - '_': '/tools/buildbot/bin/python'} 08:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:38:12 INFO - Cleaning up... 08:38:12 INFO - Return code: 0 08:38:12 INFO - Running post-action listener: _resource_record_post_action 08:38:12 INFO - Running post-action listener: _start_resource_monitoring 08:38:12 INFO - Starting resource monitoring. 08:38:12 INFO - [mozharness: 2017-03-22 15:38:12.787964Z] Finished create-virtualenv step (success) 08:38:12 INFO - [mozharness: 2017-03-22 15:38:12.788438Z] Running install step. 08:38:12 INFO - Running pre-action listener: _resource_record_pre_action 08:38:12 INFO - Running main action method: install 08:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:12 INFO - Reading from file tmpfile_stdout 08:38:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:13 INFO - Reading from file tmpfile_stdout 08:38:13 INFO - Output received: 08:38:13 INFO - Usage: mozinstall [options] installer 08:38:13 INFO - Options: 08:38:13 INFO - -h, --help show this help message and exit 08:38:13 INFO - -d DEST, --destination=DEST 08:38:13 INFO - Directory to install application into. [default: 08:38:13 INFO - "/builds/slave/test"] 08:38:13 INFO - --app=APP Application being installed. [default: firefox] 08:38:13 INFO - mkdir: /builds/slave/test/build/application 08:38:13 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:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:38:28 INFO - Reading from file tmpfile_stdout 08:38:28 INFO - Output received: 08:38:28 INFO - /builds/slave/test/build/application/firefox/firefox 08:38:28 INFO - Running post-action listener: _resource_record_post_action 08:38:28 INFO - [mozharness: 2017-03-22 15:38:28.588438Z] Finished install step (success) 08:38:28 INFO - [mozharness: 2017-03-22 15:38:28.588714Z] Running run-tests step. 08:38:28 INFO - Running pre-action listener: _resource_record_pre_action 08:38:28 INFO - Running main action method: run_tests 08:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:38:28 INFO - Python 2.7.3 08:38:28 INFO - Return code: 0 08:38:28 INFO - grabbing minidump binary from tooltool 08:38:28 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:38:28 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 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:38:28 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:38:28 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:38:28 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:38:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:38:28 INFO - Return code: 0 08:38:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:38:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:38:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:38:28 INFO - ENV: RUST_BACKTRACE is now 1 08:38:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:38:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:38:28 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/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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:38:28 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/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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:38:28 INFO - Using env: {'DISPLAY': ':0', 08:38:28 INFO - 'HOME': '/home/cltbld', 08:38:28 INFO - 'LANG': 'en_US.UTF-8', 08:38:28 INFO - 'LANGUAGE': 'en_US:en', 08:38:28 INFO - 'LOGNAME': 'cltbld', 08:38:28 INFO - 'MAIL': '/var/mail/cltbld', 08:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:28 INFO - 'MOZ_NO_REMOTE': '1', 08:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:28 INFO - 'NO_EM_RESTART': '1', 08:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:28 INFO - 'PWD': '/builds/slave/test', 08:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:38:28 INFO - 'RUST_BACKTRACE': '1', 08:38:28 INFO - 'SHELL': '/bin/bash', 08:38:28 INFO - 'SHLVL': '1', 08:38:28 INFO - 'TERM': 'linux', 08:38:28 INFO - 'TMOUT': '86400', 08:38:28 INFO - 'USER': 'cltbld', 08:38:28 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431', 08:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:28 INFO - '_': '/tools/buildbot/bin/python'} 08:38:28 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/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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:38:28 INFO - mozversion application_buildid: 20170322145832 08:38:28 INFO - mozversion application_changeset: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 08:38:28 INFO - mozversion application_display_name: Nightly 08:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:38:28 INFO - mozversion application_name: Firefox 08:38:28 INFO - mozversion application_remotingname: firefox 08:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:38:28 INFO - mozversion application_vendor: Mozilla 08:38:28 INFO - mozversion application_version: 55.0a1 08:38:28 INFO - mozversion platform_buildid: 20170322145832 08:38:28 INFO - mozversion platform_changeset: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 08:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:38:28 INFO - mozversion platform_version: 55.0a1 08:38:28 INFO - using testdate: 1490197108 08:38:28 INFO - actual date: 1490197108 08:38:28 INFO - starting webserver on 'localhost:56497' 08:38:28 INFO - SUITE-START | Running 2 tests 08:38:28 INFO - TEST-START | dromaeo_css 08:38:28 INFO - operating with platform_type : linux_ 08:38:28 INFO - Initialising browser for dromaeo_css test... 08:38:28 INFO - TEST-INFO | started process 27858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl86NXb/profile http://localhost:56497/getInfo.html) 08:38:33 INFO - PID 27858 | __metrics Screen width/height:1600/1200 08:38:33 INFO - PID 27858 | colorDepth:24 08:38:33 INFO - PID 27858 | Browser inner width/height: 1024/697 08:38:33 INFO - PID 27858 | __metrics 08:38:34 ERROR - PID 27858 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:38:35 INFO - TEST-INFO | 27858: exit 0 08:38:35 INFO - Browser initialized. 08:38:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:38:35 INFO - TEST-INFO | started process 27986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl86NXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:47 INFO - PID 27986 | RSS: Main: 155099136 08:38:47 INFO - PID 27986 | 08:41:51 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56497/tests/dromaeo/cssquery-ext.html) 08:41:54 INFO - PID 27986 | RSS: Main: 164569088 08:41:54 INFO - PID 27986 | 08:43:35 INFO - PID 27986 | ************************* 08:43:35 INFO - PID 27986 | A coding exception was thrown and uncaught in a Task. 08:43:35 INFO - PID 27986 | 08:43:35 ERROR - PID 27986 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:43:35 INFO - PID 27986 | Full stack: 08:43:35 INFO - PID 27986 | ************************* 08:44:56 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-ext.html (next: http://localhost:56497/tests/dromaeo/cssquery-jquery.html) 08:44:57 INFO - PID 27986 | RSS: Main: 161091584 08:44:57 INFO - PID 27986 | 08:47:59 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56497/tests/dromaeo/cssquery-mootools.html) 08:47:59 INFO - PID 27986 | RSS: Main: 169111552 08:47:59 INFO - PID 27986 | 08:51:01 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56497/tests/dromaeo/cssquery-prototype.html) 08:51:02 INFO - PID 27986 | RSS: Main: 161398784 08:51:02 INFO - PID 27986 | 08:54:05 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56497/tests/dromaeo/cssquery-yui.html) 08:54:05 INFO - PID 27986 | RSS: Main: 169762816 08:54:05 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | Cycle 1(1): loaded http://localhost:56497/tests/dromaeo/cssquery-yui.html (next: http://localhost:56497/tests/dromaeo/cssquery-dojo.html) 08:57:09 INFO - PID 27986 | RSS: Main: 161599488 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | __start_tp_report 08:57:09 INFO - PID 27986 | _x_x_mozilla_page_load 08:57:09 INFO - PID 27986 | _x_x_mozilla_page_load_details 08:57:09 INFO - PID 27986 | |i|pagename|runs| 08:57:09 INFO - PID 27986 | |0;dojo.html;2677.986610066949;2682.4366882954578;2691.9327016824577;2714.267147870075;2726.8909243630255;5085.237214417839;5119.2321151827155;5149.742512874355;5181.844544663657;5235.3194084768975;5170.793168273264;5190.4550022247595;5203.947960520393;5229.8169564065265;5257.185136303879;4755.239161734124;4773.57037866592;4797.544233297831;4810.374651295327;4840.830570930018;4803.111424386482;4814.951850481503;4860.149473842063;4873.512648735134;4912.091263116335;4661.277501987197;4703.811847526094;4738.905221895578;4776.522347765231;4794.616430685537;4747.620190384761;4760.381150450454;4767;4800;4815.398075240595;4649.070185962821;4727.64542659302;4727.763611819395;4745.3593764842;4767.570918617341;5057.620678449131;5104.51507106828;5211.661242019294;5238.240455134022;5294.788208471657;5586.385497595261;5610.326760788691;5647.37878833328;5656.519195868356;5657.519110875581;5628.240187574707;5636.830895073113;5654.067078931971;5656.208130861683;5658.603897727161;5115.411727651368;5235.188545775411;5238.764255608507;5249.816256431007;5286.022085914041;5676;5765.913511297334;5775.422457754191;5784.768609255582;5805.390434004453;5328.17413300939;5433.972830135824;5435.836924892181;5440.891182176413;5451;5473.042217611902;5504.366997795305;5524.972375138099;5551.084071128299;5560.777568897199;5511.4213007633625;5514.420985796514;5521.3926468088475;5523.784767351176;5540.972295138498;5492.395836457987;5499.780008799683;5500.80747173847;5506.421825708243;5517.337919449692;4650.790714417792;4659.021605462891;4661.207594708908;4663.51033141522;4664.79008444614;4029.5768944261017;4051.655609273245;4057.2494088593703;4064.451299074646;4080.2451546464;4712.976435117871;4868.172410690191;4876.512348765095;4877.5366340197625;4904.779284932187;5525.143602741581;5642.463965923231;5672.943270567324;5673.347565030074;5689.9146512802345;4835.540623640749;4854.271859221074;4860;4865.318855360252;4909.975450122726;4954.5540901319055;4962.776675049631;4971.080350135237;4977.9751101244265;5010.323606313101;5131.076406246912;5178.766955486937;5190.740462976912;5194.8961020780125;5197.662151960261;5511.807086751945;5514.80698175562;5515.61390702647;5521.199426083115;5525.254090697705;5122.206058061007;5131.179011358165;5138.717370544656;5139.922901156411;5141.177411614124;5391.703456309784;5400.1899715043055;5415.1335786274;5452.836414907559;5502.009638265151;5591.496765291144;5662.716864156693;5671.631343962629;5700.116481945305;5711.314642242957;5484.478974497416;5495.148252020783;5495.258140151029;5496.285482887199;5498.257735205696;5244.793697449684;5433.1035379161995;5452.972735136299;5462.945370546244;5478.342598888159;5265.868353291198;5389.029974604452;5416.539594134385;5430.348358197041;5434.918476222939;5308.840734777963;5511.862203444946;5512.724363781875;5515.310586176728;5530.640508366943;5280.102382594891;5301.098813201842;5331;5334.75993580282;5344.866378340573 08:57:09 INFO - PID 27986 | |1;ext.html;705.6083873450235;1057.2652006855235;1073.7530368015357;1184.8104303311472;1206.758648270345;31780.523292150636;32578.837105814466;32615.67384326156;32618;32718.182045448877;32693;33298.33403331938;33382.165445863866;33388.16529586761;33392.16519587012;6783.321667833215;7204.351608355247;7338.633068346561;7339.522931009494;7345.3021962913435;7496.137944136412;7638.350740187063;7641.732539361124;7642.350400215988;7646.235376462365;7604.505707129047;7646.158922518546;7684.231576842327;7688.11586667532;7694.7306844260465;7573.2805383488485;7588.506747061479;7601.201873803282;7609.505382150142;7637;7350.338469537767;7495.437842161859;7512.624368781594;7514.8121296967465;7522.796352583615;34402.82798586016;34574.6542534574;34605;34609.30781384358;34773.30453390943;2657.070025491082;2661.3213630524288;2663.2942270298386;2703.443874371118;2746.052611848909;24441.755582444126;24449.87775061131;24669.87665061681;24809.1316803911;25359.619605705928;3018.72831445171;3027.318853258021;3057.373238486105;3068.527106988658;3099.3336432667083;145465.27267363702;146399;146455.53544464527;147053;147078.26460867628;32966.50550241748;33817;37240.25519489595;37944.05139871525;38273;38838.22323553513;38902;39253.80373098116;39307.80346098251;39452.21095578073;12881.871181288067;13070.934645326903;13086.345682715826;13087;13113.27876966757;10135.935726748732;10179.287449878586;10284.742881427874;10335.018173273527;10371.740706482247;12471.251724896536;12525.185862918881;12583.496660133493;12647.557335493213;12782.61652150437;5196.558292545176;5251.422343542207;5267.604929630293;5293.364796224478;5345.572354211654;852.8805967164602;862.6721845698594;885.9479094519319;892.4154678685471;907.3648446087765;20397.49006274855;21321.25375611877;21333;21377.35867923965;21386.465338366666;965.4593427680381;968.2592816495387;986.8815742110993;990.3612170150212;991.8710567626307;10956.671299861016;10971.725706857393;11158.386288754196;11264.94367528157;11276.436178191057;218799;219987;220755;220788;221320;41947.58052419498;41977.790111049246;42235.7888210557;42276.78861605672;42340.57659423428;1179.5372136709793;1215.8784121587948;1221.065884598283;1227.9386030698429;1229.20101933742;19699.21203151858;20335.28826491125;20570.691439628117;20979;21119.15523379109;29053;29459.55810662799;29468.410631787672;29475.852620736758;29486.410271794015;198783;199375;199631;199846;200336;27223.86388068047;27911.581326279716;27946.72053279441;28378.716212838433;28512.57231141576;34402.82798585991;35964.4605330915;36203.456948146326;36969.44545831761;37323.81338093292;30550.541741874335;30756.231094222825;30774.230644234074;31289.374212515166;31873.203169920936;31260.531092034093;31465.8426707865;31477.055688329387;31528.684713152576;31824;30596.388072238875;30645.387092258476;30678;31035.379292414476;31159.37681246317;25603.487930241663;26514.337141570843;28362.85818570894;28641.28396790097;28665.570016449354;22312.21907233304;22571.09715611357;22669;22783;22860.542789144456 08:57:09 INFO - PID 27986 | |2;jquery.html;423.4727763933903;428.67774745720664;430.4963193064116;446.522221223291;448.824958266276;16873.818832681718;17307.653846923055;17988.64022719548;18152.909235453822;18226.088695565202;17653.82346176538;17897.82102178978;19345.129469173884;19511.41465756026;19560.608787824236;5649.548036157097;5738.7991420300405;5754.798582049629;5790.7683692652245;5798.797042103527;5785.768569257225;5900.1739756434135;5900.763969441217;5905.852353691149;5907.43879331465;5601.691906945137;5827.941720582782;5855.385184555625;5856.590038697293;5860.619059761123;5557.694326812024;5737.282839645044;5738.913916291259;5789.218455508494;5791.768329266824;5143.099957507421;5174.922376164361;5178.974105129488;5179.896402071938;5184.351956005499;21556.568868622697;22622.54754904909;22765.430864228525;22891.084356625714;22907.19824806124;1596.1221328269405;1601.7277062899336;1617.2964760329294;1640.75388691696;1662.8752843536784;13510.32448377587;13568.660783480393;13900.582982510541;14212.50256241037;14884.10695358282;1625.4554724167417;1630.0952971101035;1647.3081305851572;1661.4517209320895;1662.8752843536784;89336;89465.10534894698;90580.54709726475;91171;92547.53726231393;11021.944890275498;11302.37836918961;11398.373089479992;11443.313401195956;11513.366764827848;16241.675166496603;16272.83727162737;16303.510894673178;16303.91848040776;16341.26464309109;7276.745313913988;7628.389728821792;7658.119316278588;7757.301842834172;7790.610469476504;6846.315368463114;7045.68294426752;7129.500934934608;7163.570185788765;7166.820829479305;7031.683574239171;7096.126068942087;7099.82250443743;7148.571085734872;7171.354578087997;2105.273680580228;2112.6936594193758;2128.936131916045;2170.6852506386485;2276.3853759484846;746.7050515046635;766.4558163703721;766.9654865531064;776.111352501394;787.3858390455454;14616.780748288784;14674.926625366805;14741.336639851232;15143.848561514244;15266.694666106616;773.6093272897151;774.0324594257179;777.3431450424382;785.8428314337156;794.3010151067024;7708.730194443167;7887.526748395115;8088.150744171895;8158.673653053811;8347.833043339098;443217;446243;452257;455300;461277;63154;82371.5881420589;88675.55662221777;89060;90132.54933725289;1057.9523921423554;1062.5431064642278;1066.3868275741324;1068.7274744939991;1069.2408390043156;12501.312427816558;12850.67873303175;12877.871221288042;12983;13345.266010369523;39648;40791;41366;41554.79222603868;41912;48653.5134648649;49146.866369766736;52205.47794522006;53082.73458632682;53599;8398.874016889873;8465.153484651486;8617.95691021541;8706.651733930572;8768.95615521944;12530.185537940004;12609.747805044031;12852.100352975576;12973.286469244282;13176;10961.616343427942;11142.888571114185;11336;11378.31730096197;11472.655820325404;10891.400972946563;11112.777744444904;11121.666350009513;11163.888361116286;11352.318860868374;11118.833217501582;11472.598459053894;11523.8271425927;11617.709557260798;11975.341356225492;8392.28665563434;8579.313654907468;8666.616680412937;8681.262092722189;8744.994325652377;11492.195546311677;11515.481803319039;11532.654020379403;11608;11929.701757456132 08:57:09 INFO - PID 27986 | |3;mootools.html;1273.3760457375886;1329.7274058817943;1345.8384993800742;1350.291097173984;1350.9324533773308;9392.62429502819;9792.11870931616;9801.607935682574;9807.803843923117;10032.54853531591;9731.562079706413;9918.603255869775;9940.35387699799;9944.254180936423;9949.253805964545;2166.1010680567547;2201.9559608807895;2211.402921211272;2211.6682497625325;2215.4129155773735;2136.3590922723197;2137.9037943292587;2198.9994552478665;2203.8126759225484;2208.182972300243;2145.635242008854;2169.858959167657;2192.5395666909967;2194.2868567715477;2194.297824696098;2101.5376617144357;2113.8520303578757;2115.608612406702;2129.2015494189754;2130.20117455954;1830.2861883865303;1897.127321432129;2055.393658870637;2109.567538654572;2178.986771151406;9683.176929960962;9801.950990245003;9803.607855685765;9806.852897206547;9847.359921605073;5321.255024296602;5588.636738611977;5604.607677462579;5608.859778505529;5614.494695477427;3162.414953233659;3195.792273502215;3232.5474433579316;3233.4826427771677;3260.315333779909;939.2345238630562;940.3967578702283;950.12588418655;954.4941181173989;979.5543027922349;14400.207988560625;14562.271886405637;14613.050151740103;14757.483488077865;14790.18653974031;4762.238041913277;4982.501749824988;5022;5026.84919452417;5072.4673909239;12146.331951742563;12197.207181533173;12208.877911220952;12217.205881617667;12229.449674764479;5501;5509.173623956359;5528.917066244009;5532.30846144232;5535.280413546213;4908.3619129513645;4946.554810067111;5026.773795179226;5056.064628043824;5088.6946783193125;3789.2232092420986;3911.7848518331766;3912.3349030664854;3963.8018099095507;3989.6608788253325;1133.699569614053;1140.7205234717546;1146.5585749486509;1157.242006485753;1161.651504548632;649.5972497051764;655.9147310849559;678.8506528563709;680;691.7544271783545;5221;5283.6037297202865;5506.531944784738;5605.579581531401;5633.8309850704545;779.1974266505508;810.7040930060485;811.1077814404226;827.9006519217733;838.4005436113086;3484.198634314122;3599.9820000899826;3631.6731494165124;3664.72514561409;3685.8157092145284;12666.49334026647;12980.870191298154;13090.541831036058;13204;13239.801402978963;13017.414216360286;13039.869601304055;13040.80438793419;13087.345632718327;13318.800217996737;9439.622415103457;9459.527023648927;9576.712698619192;9618.567164477616;9622.711318660451;5416.431274716256;5430.13117901134;5564.276644036249;5586.664800112007;5642.6614403135945;11377.658670239905;11555;11663.533458661897;11802.468888900192;11907.940460297643;12136.635900922987;12182.329971851634;12207.45066471993;12282;12372.381380930738;7094.219635840157;7143.285671432815;7169.677364518505;7231.710731570889;7258.782236532912;8922.241609463268;9011.098890110936;9035.412698174598;9057.637694492147;9064;7748;7836.725714600189;7874.527528348317;8022.679092836454;8108.351331893552;7990.840183196187;8117.594120294079;8121.3908956829655;8146.2261085196815;8271.586420679063;6432.324605916311;6517.73929042833;6606.942889137715;6741.089952856301;6791.320867913169;4961.08219979305;5007.8748031298055;5025.422076461107;5162.845114646567;5176.171812509981;5044.54599086084;5095.13382724945;5127.359080114986;5130.5529153582465;5390.110631745718 08:57:09 INFO - PID 27986 | |4;prototype.html;380.97333186676946;400.9037830920579;407.78998815609964;411.71797318836616;416.06385632327266;5366.382865970415;5532.114861622146;5570.972145139273;5585.553155747541;5617.8033768818095;5380.838574842751;5460.563154947595;5465.699386533739;5482.862928426792;5497.065498865192;4271;4271.337942618899;4280.850170244042;4288.290628606264;4290.377895205193;4057.2696914555368;4276.2516559601945;4281.48622165339;4288.571142885702;4290.2706539888295;4242.321228603424;4243.469566304212;4245.980964568496;4262.850800221993;4266.552012038738;4255.702100852942;4258.127083947783;4259.787010649487;4259.957400426003;4262.0836520148005;3724.7206459515646;3746.1571146492092;3762.0030691866677;3762.398016317376;3770.6229377062073;5147.356580427447;5348.893022139574;5363.275957745694;5369.067135831097;5382.300300960889;4836.202026665596;4891.241857512091;4895.877603059952;4896.216605343164;4917.8278760243575;5520.475554822286;5767.826965191051;5775.191473193714;5777.826665200051;5795.652260864362;4068.4507591475067;4104.153131091021;4109.6506796922295;4116.135611521554;4122.525909520384;5811.302643682785;6001.759929602811;6018.15745795589;6058.031139879557;6111.297200821918;4174.770387628649;4176.14389050244;4185.309423945076;4188.434561334242;4201.474815648044;4273.401723758614;4278.465191851019;4285.121550082225;4285.528591854956;4289.356596510548;4766.285057241442;4799.688020278671;4858.7570621468785;4878.219484882473;4885.145099607555;5775.595708300379;5788.392218816964;5790.015697331463;5801.187833703285;5835.44563266489;1465.8314293856129;1479.4465810898514;1479.4673917389732;1480.2154857925316;1482.392219190127;953.1231267234161;996.5748978960156;1007.3552926127285;1007.6322142417964;1010.2726037253166;5130;5134.638066489382;5145.048166089286;5160.845174644766;5165.71976794738;6000.459958603747;6044.274687037584;6127.20346354971;6135.202423684892;6139;4817.421909370898;5103.87240318995;5136.717480538607;5137.588992880561;5166.457521960216;3231.919202019921;3262.983685081607;3264.396086723964;3270.5094235864813;3284.556584861061;5459.972700136474;5618.157276408571;5643.576731745054;5643.971780141073;5668.858278542987;6180.3201647818705;6202.162708034358;6208.906866397007;6209.9068513972325;6244.718987645567;5586.581006424534;5607.130894711245;5610.691411972381;5638.182463542763;5640.379558248672;5757.251557297524;6029.638221706711;6038.953900886504;6047.455728984237;6066.939330606814;5964.105384192406;5965;5969.462748352669;5978.760849565969;5983.922893879144;5327.866803329948;5398.919016214839;5524.889502210013;5569.470900264469;5626.437356264504;4191.140816132746;4214.62068413832;4217.304144816071;4226.323788193874;4238.537704491945;5942.227510423617;6021.608595441282;6041.75832966694;6045.365236650088;6065.663884863396;5770.769169233352;5826.213461182686;5856.4143585641095;5861.208736820475;5864.589478736448;5816.243888294494;5828.300603927556;5838.32859221195;5858.414158584107;5872.148538461985;5552.722363881709;5735.225744524436;5740.110282905989;5746.942530574808;5769.91345129815;5856.033754430471;5872.735726892385;5882.588218824641;5886.175935369138;5894.263217097863;5488.451154884479;5709.571782116441;5714.828555143353;5722.799702010576;5757.91363129545 08:57:09 INFO - PID 27986 | |5;yui.html;679.9762008329709;681.9965900170499;686.423404340354;712.7576623947854;719.992011184342;12730.809037864428;12870.227786332827;12941.094123411365;13219.272939988308;13634.386452609631;12961.870381296185;13216.339183040858;13262.336883155851;13322.067455278135;13694.246816425093;833.3000279765012;851;866.5797088412115;868.2142660891872;870.0951010948606;847.8685803700437;853.5390888920007;878.8813510176109;880.7798050487378;884.9734507964771;897.6185121323444;918.228687902162;919.3610440743686;921.8801555797737;927.679950417105;916.0610374366262;918.3892711346946;918.728974952394;919.5310391700215;919.7746552094712;671.516508114157;675.5068799776142;677.9864402711918;678.352173674145;679.6975345971044;14456.349464274133;14627.829773618085;14778.03942743729;14827.851721482755;14883.47907823221;13083.607491775261;13871.722565548733;13877.791833122512;13898.722025559533;14001.859981400157;10039.29724919256;10281.126104281146;10412.11497022754;10491.63279285229;10516.158707303397;2707.3096360428162;2730.931726706828;2731.3444773254473;2814.9296267593268;2847.686754457008;60805.695971520305;61242.387576124114;62289;62693.37306626967;62898.685506572634;10913.945430272797;11111;11137.944310278397;11252.66242012741;11346.48940797666;21837.344879653636;21857.344279671634;21903;21951;22136.446588835086;6614.107095542136;6732.158480189976;6743.35938085881;6868.141482314711;6957.026016357714;3286.375588638151;3369.140869078369;3390.423627983249;3408.5909690837257;3458.066322093071;3507.3686736387695;3594.3530164570107;3622.3989812313957;3664.230511592542;3677.5770786359376;599.7031469422664;604.127036432351;607.696151924038;616.4913945994573;616.5930485879298;428.3510481620348;433.55127443096245;449.67398635988644;455.9886002849955;457.35969642500766;7086.787396378117;7278.053852999076;7336.303051210127;7936.880946785803;8009.839803203903;501.27815945039026;510.1124044163129;528.3105547260861;537.7472587883689;554.0968221798523;3596.604373518911;3665.981670091686;3729.8881033569037;3847.3651847445417;3887.8444862205197;54064.45935540594;55529.722351388795;55999.72000140055;56948.430515694316;57347.713261433426;48361.5163848364;48641;48768.756156218995;49849;49930.50069499331;37678.43482347767;38911.80544097262;40673.59326406698;42585.57414425878;45137.32294015527;8967.551622418983;8974.19232269099;9033.638654453749;9038.3673142882;9531.76170595713;20908.082393035824;21538.353849383915;21590.568188635825;24018.75981240165;24028;38279.617203827605;42631.786841065594;42833.357499636906;43041.569584305005;44095.77952110219;11131.666050018512;11241.71895702614;11253.606123785628;11551.826722599;11930.940345298219;10255.58977640886;10274.33216840903;10383.740406489898;10546.683599492027;10830.566777329133;11368.261063030877;11728.41357932117;11779.352135632622;12031;12214.206076604993;11177.552897883994;11343.659690209306;11474.885251147381;11903.364729518797;11944.701382465508;10896.50965706561;11059.668209953714;11081.5567377304;11146.442677866236;11414.94292528532;9245.67640132619;9856.802863942537;10089.697309080739;10231.7442063949;10234.053921789091;10277.84583231267;10703.966246413156;10749.4201391667;10806.13550915909;10837.295575787864 08:57:09 INFO - PID 27986 | __end_tp_report 08:57:09 INFO - PID 27986 | __start_cc_report 08:57:09 INFO - PID 27986 | _x_x_mozilla_cycle_collect,380 08:57:09 INFO - PID 27986 | __end_cc_report 08:57:09 INFO - PID 27986 | __startTimestamp1490198229307__endTimestamp 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | ------- Summary: start ------- 08:57:09 INFO - PID 27986 | Number of tests: 6 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#0] dojo.html Cycles:165 Average:5134.17 Median:5249.82 stddev:575.08 (11.0%) stddev-sans-first:543.61 08:57:09 INFO - PID 27986 | Values: 2678.0 2682.4 2691.9 2714.3 2726.9 5085.2 5119.2 5149.7 5181.8 5235.3 5170.8 5190.5 5203.9 5229.8 5257.2 4755.2 4773.6 4797.5 4810.4 4840.8 4803.1 4815.0 4860.1 4873.5 4912.1 4661.3 4703.8 4738.9 4776.5 4794.6 4747.6 4760.4 4767.0 4800.0 4815.4 4649.1 4727.6 4727.8 4745.4 4767.6 5057.6 5104.5 5211.7 5238.2 5294.8 5586.4 5610.3 5647.4 5656.5 5657.5 5628.2 5636.8 5654.1 5656.2 5658.6 5115.4 5235.2 5238.8 5249.8 5286.0 5676.0 5765.9 5775.4 5784.8 5805.4 5328.2 5434.0 5435.8 5440.9 5451.0 5473.0 5504.4 5525.0 5551.1 5560.8 5511.4 5514.4 5521.4 5523.8 5541.0 5492.4 5499.8 5500.8 5506.4 5517.3 4650.8 4659.0 4661.2 4663.5 4664.8 4029.6 4051.7 4057.2 4064.5 4080.2 4713.0 4868.2 4876.5 4877.5 4904.8 5525.1 5642.5 5672.9 5673.3 5689.9 4835.5 4854.3 4860.0 4865.3 4910.0 4954.6 4962.8 4971.1 4978.0 5010.3 5131.1 5178.8 5190.7 5194.9 5197.7 5511.8 5514.8 5515.6 5521.2 5525.3 5122.2 5131.2 5138.7 5139.9 5141.2 5391.7 5400.2 5415.1 5452.8 5502.0 5591.5 5662.7 5671.6 5700.1 5711.3 5484.5 5495.1 5495.3 5496.3 5498.3 5244.8 5433.1 5453.0 5462.9 5478.3 5265.9 5389.0 5416.5 5430.3 5434.9 5308.8 5511.9 5512.7 5515.3 5530.6 5280.1 5301.1 5331.0 5334.8 5344.9 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#1] ext.html Cycles:180 Average:32982.49 Median:16873.26 stddev:49624.46 (294.1%) stddev-sans-first:49704.49 08:57:09 INFO - PID 27986 | Values: 705.6 1057.3 1073.8 1184.8 1206.8 31780.5 32578.8 32615.7 32618.0 32718.2 32693.0 33298.3 33382.2 33388.2 33392.2 6783.3 7204.4 7338.6 7339.5 7345.3 7496.1 7638.4 7641.7 7642.4 7646.2 7604.5 7646.2 7684.2 7688.1 7694.7 7573.3 7588.5 7601.2 7609.5 7637.0 7350.3 7495.4 7512.6 7514.8 7522.8 34402.8 34574.7 34605.0 34609.3 34773.3 2657.1 2661.3 2663.3 2703.4 2746.1 24441.8 24449.9 24669.9 24809.1 25359.6 3018.7 3027.3 3057.4 3068.5 3099.3 145465.3 146399.0 146455.5 147053.0 147078.3 32966.5 33817.0 37240.3 37944.1 38273.0 38838.2 38902.0 39253.8 39307.8 39452.2 12881.9 13070.9 13086.3 13087.0 13113.3 10135.9 10179.3 10284.7 10335.0 10371.7 12471.3 12525.2 12583.5 12647.6 12782.6 5196.6 5251.4 5267.6 5293.4 5345.6 852.9 862.7 885.9 892.4 907.4 20397.5 21321.3 21333.0 21377.4 21386.5 965.5 968.3 986.9 990.4 991.9 10956.7 10971.7 11158.4 11264.9 11276.4 218799.0 219987.0 220755.0 220788.0 221320.0 41947.6 41977.8 42235.8 42276.8 42340.6 1179.5 1215.9 1221.1 1227.9 1229.2 19699.2 20335.3 20570.7 20979.0 21119.2 29053.0 29459.6 29468.4 29475.9 29486.4 198783.0 199375.0 199631.0 199846.0 200336.0 27223.9 27911.6 27946.7 28378.7 28512.6 34402.8 35964.5 36203.5 36969.4 37323.8 30550.5 30756.2 30774.2 31289.4 31873.2 31260.5 31465.8 31477.1 31528.7 31824.0 30596.4 30645.4 30678.0 31035.4 31159.4 25603.5 26514.3 28362.9 28641.3 28665.6 22312.2 22571.1 22669.0 22783.0 22860.5 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#2] jquery.html Cycles:180 Average:27446.20 Median:426.08 stddev:74702.39 (17532.7%) stddev-sans-first:74884.40 08:57:09 INFO - PID 27986 | Values: 423.5 428.7 430.5 446.5 448.8 16873.8 17307.7 17988.6 18152.9 18226.1 17653.8 17897.8 19345.1 19511.4 19560.6 5649.5 5738.8 5754.8 5790.8 5798.8 5785.8 5900.2 5900.8 5905.9 5907.4 5601.7 5827.9 5855.4 5856.6 5860.6 5557.7 5737.3 5738.9 5789.2 5791.8 5143.1 5174.9 5179.0 5179.9 5184.4 21556.6 22622.5 22765.4 22891.1 22907.2 1596.1 1601.7 1617.3 1640.8 1662.9 13510.3 13568.7 13900.6 14212.5 14884.1 1625.5 1630.1 1647.3 1661.5 1662.9 89336.0 89465.1 90580.5 91171.0 92547.5 11021.9 11302.4 11398.4 11443.3 11513.4 16241.7 16272.8 16303.5 16303.9 16341.3 7276.7 7628.4 7658.1 7757.3 7790.6 6846.3 7045.7 7129.5 7163.6 7166.8 7031.7 7096.1 7099.8 7148.6 7171.4 2105.3 2112.7 2128.9 2170.7 2276.4 746.7 766.5 767.0 776.1 787.4 14616.8 14674.9 14741.3 15143.8 15266.7 773.6 774.0 777.3 785.8 794.3 7708.7 7887.5 8088.2 8158.7 8347.8 443217.0 446243.0 452257.0 455300.0 461277.0 63154.0 82371.6 88675.6 89060.0 90132.5 1058.0 1062.5 1066.4 1068.7 1069.2 12501.3 12850.7 12877.9 12983.0 13345.3 39648.0 40791.0 41366.0 41554.8 41912.0 48653.5 49146.9 52205.5 53082.7 53599.0 8398.9 8465.2 8618.0 8706.7 8769.0 12530.2 12609.7 12852.1 12973.3 13176.0 10961.6 11142.9 11336.0 11378.3 11472.7 10891.4 11112.8 11121.7 11163.9 11352.3 11118.8 11472.6 11523.8 11617.7 11975.3 8392.3 8579.3 8666.6 8681.3 8745.0 11492.2 11515.5 11532.7 11608.0 11929.7 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#3] mootools.html Cycles:180 Average:6203.20 Median:5035.70 stddev:4028.60 (80.0%) stddev-sans-first:4022.87 08:57:09 INFO - PID 27986 | Values: 1273.4 1329.7 1345.8 1350.3 1350.9 9392.6 9792.1 9801.6 9807.8 10032.5 9731.6 9918.6 9940.4 9944.3 9949.3 2166.1 2202.0 2211.4 2211.7 2215.4 2136.4 2137.9 2199.0 2203.8 2208.2 2145.6 2169.9 2192.5 2194.3 2194.3 2101.5 2113.9 2115.6 2129.2 2130.2 1830.3 1897.1 2055.4 2109.6 2179.0 9683.2 9802.0 9803.6 9806.9 9847.4 5321.3 5588.6 5604.6 5608.9 5614.5 3162.4 3195.8 3232.5 3233.5 3260.3 939.2 940.4 950.1 954.5 979.6 14400.2 14562.3 14613.1 14757.5 14790.2 4762.2 4982.5 5022.0 5026.8 5072.5 12146.3 12197.2 12208.9 12217.2 12229.4 5501.0 5509.2 5528.9 5532.3 5535.3 4908.4 4946.6 5026.8 5056.1 5088.7 3789.2 3911.8 3912.3 3963.8 3989.7 1133.7 1140.7 1146.6 1157.2 1161.7 649.6 655.9 678.9 680.0 691.8 5221.0 5283.6 5506.5 5605.6 5633.8 779.2 810.7 811.1 827.9 838.4 3484.2 3600.0 3631.7 3664.7 3685.8 12666.5 12980.9 13090.5 13204.0 13239.8 13017.4 13039.9 13040.8 13087.3 13318.8 9439.6 9459.5 9576.7 9618.6 9622.7 5416.4 5430.1 5564.3 5586.7 5642.7 11377.7 11555.0 11663.5 11802.5 11907.9 12136.6 12182.3 12207.5 12282.0 12372.4 7094.2 7143.3 7169.7 7231.7 7258.8 8922.2 9011.1 9035.4 9057.6 9064.0 7748.0 7836.7 7874.5 8022.7 8108.4 7990.8 8117.6 8121.4 8146.2 8271.6 6432.3 6517.7 6606.9 6741.1 6791.3 4961.1 5007.9 5025.4 5162.8 5176.2 5044.5 5095.1 5127.4 5130.6 5390.1 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#4] prototype.html Cycles:180 Average:4817.67 Median:5390.61 stddev:1402.85 (26.0%) stddev-sans-first:1366.69 08:57:09 INFO - PID 27986 | Values: 381.0 400.9 407.8 411.7 416.1 5366.4 5532.1 5571.0 5585.6 5617.8 5380.8 5460.6 5465.7 5482.9 5497.1 4271.0 4271.3 4280.9 4288.3 4290.4 4057.3 4276.3 4281.5 4288.6 4290.3 4242.3 4243.5 4246.0 4262.9 4266.6 4255.7 4258.1 4259.8 4260.0 4262.1 3724.7 3746.2 3762.0 3762.4 3770.6 5147.4 5348.9 5363.3 5369.1 5382.3 4836.2 4891.2 4895.9 4896.2 4917.8 5520.5 5767.8 5775.2 5777.8 5795.7 4068.5 4104.2 4109.7 4116.1 4122.5 5811.3 6001.8 6018.2 6058.0 6111.3 4174.8 4176.1 4185.3 4188.4 4201.5 4273.4 4278.5 4285.1 4285.5 4289.4 4766.3 4799.7 4858.8 4878.2 4885.1 5775.6 5788.4 5790.0 5801.2 5835.4 1465.8 1479.4 1479.5 1480.2 1482.4 953.1 996.6 1007.4 1007.6 1010.3 5130.0 5134.6 5145.0 5160.8 5165.7 6000.5 6044.3 6127.2 6135.2 6139.0 4817.4 5103.9 5136.7 5137.6 5166.5 3231.9 3263.0 3264.4 3270.5 3284.6 5460.0 5618.2 5643.6 5644.0 5668.9 6180.3 6202.2 6208.9 6209.9 6244.7 5586.6 5607.1 5610.7 5638.2 5640.4 5757.3 6029.6 6039.0 6047.5 6066.9 5964.1 5965.0 5969.5 5978.8 5983.9 5327.9 5398.9 5524.9 5569.5 5626.4 4191.1 4214.6 4217.3 4226.3 4238.5 5942.2 6021.6 6041.8 6045.4 6065.7 5770.8 5826.2 5856.4 5861.2 5864.6 5816.2 5828.3 5838.3 5858.4 5872.1 5552.7 5735.2 5740.1 5746.9 5769.9 5856.0 5872.7 5882.6 5886.2 5894.3 5488.5 5709.6 5714.8 5722.8 5757.9 08:57:09 INFO - PID 27986 | 08:57:09 INFO - PID 27986 | [#5] yui.html Cycles:180 Average:13649.40 Median:20704.16 stddev:16040.76 (77.5%) stddev-sans-first:16056.19 08:57:09 INFO - PID 27986 | Values: 680.0 682.0 686.4 712.8 720.0 12730.8 12870.2 12941.1 13219.3 13634.4 12961.9 13216.3 13262.3 13322.1 13694.2 833.3 851.0 866.6 868.2 870.1 847.9 853.5 878.9 880.8 885.0 897.6 918.2 919.4 921.9 927.7 916.1 918.4 918.7 919.5 919.8 671.5 675.5 678.0 678.4 679.7 14456.3 14627.8 14778.0 14827.9 14883.5 13083.6 13871.7 13877.8 13898.7 14001.9 10039.3 10281.1 10412.1 10491.6 10516.2 2707.3 2730.9 2731.3 2814.9 2847.7 60805.7 61242.4 62289.0 62693.4 62898.7 10913.9 11111.0 11137.9 11252.7 11346.5 21837.3 21857.3 21903.0 21951.0 22136.4 6614.1 6732.2 6743.4 6868.1 6957.0 3286.4 3369.1 3390.4 3408.6 3458.1 3507.4 3594.4 3622.4 3664.2 3677.6 599.7 604.1 607.7 616.5 616.6 428.4 433.6 449.7 456.0 457.4 7086.8 7278.1 7336.3 7936.9 8009.8 501.3 510.1 528.3 537.7 554.1 3596.6 3666.0 3729.9 3847.4 3887.8 54064.5 55529.7 55999.7 56948.4 57347.7 48361.5 48641.0 48768.8 49849.0 49930.5 37678.4 38911.8 40673.6 42585.6 45137.3 8967.6 8974.2 9033.6 9038.4 9531.8 20908.1 21538.4 21590.6 24018.8 24028.0 38279.6 42631.8 42833.4 43041.6 44095.8 11131.7 11241.7 11253.6 11551.8 11930.9 10255.6 10274.3 10383.7 10546.7 10830.6 11368.3 11728.4 11779.4 12031.0 12214.2 11177.6 11343.7 11474.9 11903.4 11944.7 10896.5 11059.7 11081.6 11146.4 11414.9 9245.7 9856.8 10089.7 10231.7 10234.1 10277.8 10704.0 10749.4 10806.1 10837.3 08:57:09 INFO - PID 27986 | -------- Summary: end -------- 08:57:09 INFO - PID 27986 | 08:57:10 INFO - TEST-INFO | 27986: exit 0 08:57:10 INFO - TEST-OK | dromaeo_css | took 1121300ms 08:57:10 INFO - TEST-START | kraken 08:57:10 INFO - operating with platform_type : linux_ 08:57:10 INFO - Initialising browser for kraken test... 08:57:10 INFO - TEST-INFO | started process 28361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI41Ha2/profile http://localhost:56497/getInfo.html) 08:57:14 INFO - PID 28361 | __metrics Screen width/height:1600/1200 08:57:14 INFO - PID 28361 | colorDepth:24 08:57:14 INFO - PID 28361 | Browser inner width/height: 1024/697 08:57:14 INFO - PID 28361 | __metrics 08:57:15 ERROR - PID 28361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:57:16 INFO - TEST-INFO | 28361: exit 0 08:57:16 INFO - Browser initialized. 08:57:16 INFO - Running cycle 1/1 for kraken test... 08:57:16 INFO - TEST-INFO | started process 28496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI41Ha2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:28 INFO - PID 28496 | RSS: Main: 154877952 08:57:28 INFO - PID 28496 | 08:57:31 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56497/tests/kraken/driver.html?testName=audio-beat-detection) 08:57:32 INFO - PID 28496 | RSS: Main: 160661504 08:57:32 INFO - PID 28496 | 08:57:34 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56497/tests/kraken/driver.html?testName=audio-dft) 08:57:35 INFO - PID 28496 | RSS: Main: 160866304 08:57:35 INFO - PID 28496 | 08:57:38 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56497/tests/kraken/driver.html?testName=audio-fft) 08:57:39 INFO - PID 28496 | RSS: Main: 157286400 08:57:39 INFO - PID 28496 | 08:57:41 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56497/tests/kraken/driver.html?testName=audio-oscillator) 08:57:41 INFO - PID 28496 | RSS: Main: 157487104 08:57:41 INFO - PID 28496 | 08:57:43 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:44 INFO - PID 28496 | RSS: Main: 157507584 08:57:44 INFO - PID 28496 | 08:57:47 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56497/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:48 INFO - PID 28496 | RSS: Main: 163581952 08:57:48 INFO - PID 28496 | 08:57:52 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56497/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:52 INFO - PID 28496 | RSS: Main: 160165888 08:57:52 INFO - PID 28496 | 08:57:55 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56497/tests/kraken/driver.html?testName=json-parse-financial) 08:57:56 INFO - PID 28496 | RSS: Main: 162037760 08:57:56 INFO - PID 28496 | 08:57:58 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:58 INFO - PID 28496 | RSS: Main: 162402304 08:57:58 INFO - PID 28496 | 08:58:00 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:01 INFO - PID 28496 | RSS: Main: 162054144 08:58:01 INFO - PID 28496 | 08:58:03 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:03 INFO - PID 28496 | RSS: Main: 162873344 08:58:03 INFO - PID 28496 | 08:58:06 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:07 INFO - PID 28496 | RSS: Main: 163065856 08:58:07 INFO - PID 28496 | 08:58:10 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:11 INFO - PID 28496 | RSS: Main: 162553856 08:58:11 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | Cycle 1(1): loaded http://localhost:56497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56497/tests/kraken/driver.html?testName=ai-astar) 08:58:13 INFO - PID 28496 | RSS: Main: 164085760 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | __start_tp_report 08:58:13 INFO - PID 28496 | _x_x_mozilla_page_load 08:58:13 INFO - PID 28496 | _x_x_mozilla_page_load_details 08:58:13 INFO - PID 28496 | |i|pagename|runs| 08:58:13 INFO - PID 28496 | |0;ai-astar;103;113;112;111;110;114;111;111;112;112 08:58:13 INFO - PID 28496 | |1;audio-beat-detection;150;125;131;185;129;126;123;126;146;126 08:58:13 INFO - PID 28496 | |2;audio-dft;163;165;166;167;176;162;164;165;167;167 08:58:13 INFO - PID 28496 | |3;audio-fft;76;76;77;108;77;76;76;75;91;75 08:58:13 INFO - PID 28496 | |4;audio-oscillator;84;84;106;85;83;83;99;83;84;110 08:58:13 INFO - PID 28496 | |5;imaging-gaussian-blur;114;114;114;115;115;114;114;114;114;113 08:58:13 INFO - PID 28496 | |6;imaging-darkroom;151;150;150;152;150;152;149;149;152;155 08:58:13 INFO - PID 28496 | |7;imaging-desaturate;95;94;95;95;94;94;95;94;96;94 08:58:13 INFO - PID 28496 | |8;json-parse-financial;71;68;68;73;71;70;69;70;69;73 08:58:13 INFO - PID 28496 | |9;json-stringify-tinderbox;55;55;56;55;55;55;55;56;54;55 08:58:13 INFO - PID 28496 | |10;stanford-crypto-aes;83;87;87;83;88;84;83;83;84;82 08:58:13 INFO - PID 28496 | |11;stanford-crypto-ccm;144;152;141;135;139;143;135;140;191;135 08:58:13 INFO - PID 28496 | |12;stanford-crypto-pbkdf2;185;199;198;198;195;194;193;200;195;193 08:58:13 INFO - PID 28496 | |13;stanford-crypto-sha256-iterative;75;70;71;73;71;75;71;71;72;72 08:58:13 INFO - PID 28496 | __end_tp_report 08:58:13 INFO - PID 28496 | __start_cc_report 08:58:13 INFO - PID 28496 | _x_x_mozilla_cycle_collect,873 08:58:13 INFO - PID 28496 | __end_cc_report 08:58:13 INFO - PID 28496 | __startTimestamp1490198293489__endTimestamp 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | ------- Summary: start ------- 08:58:13 INFO - PID 28496 | Number of tests: 14 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.00 (2.7%) stddev-sans-first:1.20 08:58:13 INFO - PID 28496 | Values: 103.0 113.0 112.0 111.0 110.0 114.0 111.0 111.0 112.0 112.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:130.00 stddev:19.31 (14.9%) stddev-sans-first:19.87 08:58:13 INFO - PID 28496 | Values: 150.0 125.0 131.0 185.0 129.0 126.0 123.0 126.0 146.0 126.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:3.85 (2.3%) stddev-sans-first:3.91 08:58:13 INFO - PID 28496 | Values: 163.0 165.0 166.0 167.0 176.0 162.0 164.0 165.0 167.0 167.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:10.71 (14.1%) stddev-sans-first:11.22 08:58:13 INFO - PID 28496 | Values: 76.0 76.0 77.0 108.0 77.0 76.0 76.0 75.0 91.0 75.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:10.63 (12.7%) stddev-sans-first:11.04 08:58:13 INFO - PID 28496 | Values: 84.0 84.0 106.0 85.0 83.0 83.0 99.0 83.0 84.0 110.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:58:13 INFO - PID 28496 | Values: 114.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 113.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.83 (1.2%) stddev-sans-first:1.94 08:58:13 INFO - PID 28496 | Values: 151.0 150.0 150.0 152.0 150.0 152.0 149.0 149.0 152.0 155.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:58:13 INFO - PID 28496 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 96.0 94.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.50 stddev:1.81 (2.6%) stddev-sans-first:1.90 08:58:13 INFO - PID 28496 | Values: 71.0 68.0 68.0 73.0 71.0 70.0 69.0 70.0 69.0 73.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 08:58:13 INFO - PID 28496 | Values: 55.0 55.0 56.0 55.0 55.0 55.0 55.0 56.0 54.0 55.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.12 (2.5%) stddev-sans-first:2.19 08:58:13 INFO - PID 28496 | Values: 83.0 87.0 87.0 83.0 88.0 84.0 83.0 83.0 84.0 82.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:142.00 stddev:16.81 (11.8%) stddev-sans-first:17.83 08:58:13 INFO - PID 28496 | Values: 144.0 152.0 141.0 135.0 139.0 143.0 135.0 140.0 191.0 135.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:196.50 stddev:4.32 (2.2%) stddev-sans-first:2.67 08:58:13 INFO - PID 28496 | Values: 185.0 199.0 198.0 198.0 195.0 194.0 193.0 200.0 195.0 193.0 08:58:13 INFO - PID 28496 | 08:58:13 INFO - PID 28496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.73 (2.4%) stddev-sans-first:1.48 08:58:13 INFO - PID 28496 | Values: 75.0 70.0 71.0 73.0 71.0 75.0 71.0 71.0 72.0 72.0 08:58:13 INFO - PID 28496 | -------- Summary: end -------- 08:58:13 INFO - PID 28496 | 08:58:14 INFO - TEST-INFO | 28496: exit 0 08:58:14 INFO - TEST-OK | kraken | took 64473ms 08:58:14 INFO - SUITE-END | took 1185s 08:58:15 INFO - Completed test suite (00:19:46) 08:58:15 INFO - javascript benchmark 08:58:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6627.411103089261, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2677.986610066949, 2682.4366882954578, 2691.9327016824577, 2714.267147870075, 2726.8909243630255, 5085.237214417839, 5119.2321151827155, 5149.742512874355, 5181.844544663657, 5235.3194084768975, 5170.793168273264, 5190.4550022247595, 5203.947960520393, 5229.8169564065265, 5257.185136303879, 4755.239161734124, 4773.57037866592, 4797.544233297831, 4810.374651295327, 4840.830570930018, 4803.111424386482, 4814.951850481503, 4860.149473842063, 4873.512648735134, 4912.091263116335, 4661.277501987197, 4703.811847526094, 4738.905221895578, 4776.522347765231, 4794.616430685537, 4747.620190384761, 4760.381150450454, 4767.0, 4800.0, 4815.398075240595, 4649.070185962821, 4727.64542659302, 4727.763611819395, 4745.3593764842, 4767.570918617341, 5057.620678449131, 5104.51507106828, 5211.661242019294, 5238.240455134022, 5294.788208471657, 5586.385497595261, 5610.326760788691, 5647.37878833328, 5656.519195868356, 5657.519110875581, 5628.240187574707, 5636.830895073113, 5654.067078931971, 5656.208130861683, 5658.603897727161, 5115.411727651368, 5235.188545775411, 5238.764255608507, 5249.816256431007, 5286.022085914041, 5676.0, 5765.913511297334, 5775.422457754191, 5784.768609255582, 5805.390434004453, 5328.17413300939, 5433.972830135824, 5435.836924892181, 5440.891182176413, 5451.0, 5473.042217611902, 5504.366997795305, 5524.972375138099, 5551.084071128299, 5560.777568897199, 5511.4213007633625, 5514.420985796514, 5521.3926468088475, 5523.784767351176, 5540.972295138498, 5492.395836457987, 5499.780008799683, 5500.80747173847, 5506.421825708243, 5517.337919449692, 4650.790714417792, 4659.021605462891, 4661.207594708908, 4663.51033141522, 4664.79008444614, 4029.5768944261017, 4051.655609273245, 4057.2494088593703, 4064.451299074646, 4080.2451546464, 4712.976435117871, 4868.172410690191, 4876.512348765095, 4877.5366340197625, 4904.779284932187, 5525.143602741581, 5642.463965923231, 5672.943270567324, 5673.347565030074, 5689.9146512802345, 4835.540623640749, 4854.271859221074, 4860.0, 4865.318855360252, 4909.975450122726, 4954.5540901319055, 4962.776675049631, 4971.080350135237, 4977.9751101244265, 5010.323606313101, 5131.076406246912, 5178.766955486937, 5190.740462976912, 5194.8961020780125, 5197.662151960261, 5511.807086751945, 5514.80698175562, 5515.61390702647, 5521.199426083115, 5525.254090697705, 5122.206058061007, 5131.179011358165, 5138.717370544656, 5139.922901156411, 5141.177411614124, 5391.703456309784, 5400.1899715043055, 5415.1335786274, 5452.836414907559, 5502.009638265151, 5591.496765291144, 5662.716864156693, 5671.631343962629, 5700.116481945305, 5711.314642242957, 5484.478974497416, 5495.148252020783, 5495.258140151029, 5496.285482887199, 5498.257735205696, 5244.793697449684, 5433.1035379161995, 5452.972735136299, 5462.945370546244, 5478.342598888159, 5265.868353291198, 5389.029974604452, 5416.539594134385, 5430.348358197041, 5434.918476222939, 5308.840734777963, 5511.862203444946, 5512.724363781875, 5515.310586176728, 5530.640508366943, 5280.102382594891, 5301.098813201842, 5331.0, 5334.75993580282, 5344.866378340573], "value": 5093.450209718636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6083873450235, 1057.2652006855235, 1073.7530368015357, 1184.8104303311472, 1206.758648270345, 31780.523292150636, 32578.837105814466, 32615.67384326156, 32618.0, 32718.182045448877, 32693.0, 33298.33403331938, 33382.165445863866, 33388.16529586761, 33392.16519587012, 6783.321667833215, 7204.351608355247, 7338.633068346561, 7339.522931009494, 7345.3021962913435, 7496.137944136412, 7638.350740187063, 7641.732539361124, 7642.350400215988, 7646.235376462365, 7604.505707129047, 7646.158922518546, 7684.231576842327, 7688.11586667532, 7694.7306844260465, 7573.2805383488485, 7588.506747061479, 7601.201873803282, 7609.505382150142, 7637.0, 7350.338469537767, 7495.437842161859, 7512.624368781594, 7514.8121296967465, 7522.796352583615, 34402.82798586016, 34574.6542534574, 34605.0, 34609.30781384358, 34773.30453390943, 2657.070025491082, 2661.3213630524288, 2663.2942270298386, 2703.443874371118, 2746.052611848909, 24441.755582444126, 24449.87775061131, 24669.87665061681, 24809.1316803911, 25359.619605705928, 3018.72831445171, 3027.318853258021, 3057.373238486105, 3068.527106988658, 3099.3336432667083, 145465.27267363702, 146399.0, 146455.53544464527, 147053.0, 147078.26460867628, 32966.50550241748, 33817.0, 37240.25519489595, 37944.05139871525, 38273.0, 38838.22323553513, 38902.0, 39253.80373098116, 39307.80346098251, 39452.21095578073, 12881.871181288067, 13070.934645326903, 13086.345682715826, 13087.0, 13113.27876966757, 10135.935726748732, 10179.287449878586, 10284.742881427874, 10335.018173273527, 10371.740706482247, 12471.251724896536, 12525.185862918881, 12583.496660133493, 12647.557335493213, 12782.61652150437, 5196.558292545176, 5251.422343542207, 5267.604929630293, 5293.364796224478, 5345.572354211654, 852.8805967164602, 862.6721845698594, 885.9479094519319, 892.4154678685471, 907.3648446087765, 20397.49006274855, 21321.25375611877, 21333.0, 21377.35867923965, 21386.465338366666, 965.4593427680381, 968.2592816495387, 986.8815742110993, 990.3612170150212, 991.8710567626307, 10956.671299861016, 10971.725706857393, 11158.386288754196, 11264.94367528157, 11276.436178191057, 218799.0, 219987.0, 220755.0, 220788.0, 221320.0, 41947.58052419498, 41977.790111049246, 42235.7888210557, 42276.78861605672, 42340.57659423428, 1179.5372136709793, 1215.8784121587948, 1221.065884598283, 1227.9386030698429, 1229.20101933742, 19699.21203151858, 20335.28826491125, 20570.691439628117, 20979.0, 21119.15523379109, 29053.0, 29459.55810662799, 29468.410631787672, 29475.852620736758, 29486.410271794015, 198783.0, 199375.0, 199631.0, 199846.0, 200336.0, 27223.86388068047, 27911.581326279716, 27946.72053279441, 28378.716212838433, 28512.57231141576, 34402.82798585991, 35964.4605330915, 36203.456948146326, 36969.44545831761, 37323.81338093292, 30550.541741874335, 30756.231094222825, 30774.230644234074, 31289.374212515166, 31873.203169920936, 31260.531092034093, 31465.8426707865, 31477.055688329387, 31528.684713152576, 31824.0, 30596.388072238875, 30645.387092258476, 30678.0, 31035.379292414476, 31159.37681246317, 25603.487930241663, 26514.337141570843, 28362.85818570894, 28641.28396790097, 28665.570016449354, 22312.21907233304, 22571.09715611357, 22669.0, 22783.0, 22860.542789144456], "value": 14928.515749459704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.4727763933903, 428.67774745720664, 430.4963193064116, 446.522221223291, 448.824958266276, 16873.818832681718, 17307.653846923055, 17988.64022719548, 18152.909235453822, 18226.088695565202, 17653.82346176538, 17897.82102178978, 19345.129469173884, 19511.41465756026, 19560.608787824236, 5649.548036157097, 5738.7991420300405, 5754.798582049629, 5790.7683692652245, 5798.797042103527, 5785.768569257225, 5900.1739756434135, 5900.763969441217, 5905.852353691149, 5907.43879331465, 5601.691906945137, 5827.941720582782, 5855.385184555625, 5856.590038697293, 5860.619059761123, 5557.694326812024, 5737.282839645044, 5738.913916291259, 5789.218455508494, 5791.768329266824, 5143.099957507421, 5174.922376164361, 5178.974105129488, 5179.896402071938, 5184.351956005499, 21556.568868622697, 22622.54754904909, 22765.430864228525, 22891.084356625714, 22907.19824806124, 1596.1221328269405, 1601.7277062899336, 1617.2964760329294, 1640.75388691696, 1662.8752843536784, 13510.32448377587, 13568.660783480393, 13900.582982510541, 14212.50256241037, 14884.10695358282, 1625.4554724167417, 1630.0952971101035, 1647.3081305851572, 1661.4517209320895, 1662.8752843536784, 89336.0, 89465.10534894698, 90580.54709726475, 91171.0, 92547.53726231393, 11021.944890275498, 11302.37836918961, 11398.373089479992, 11443.313401195956, 11513.366764827848, 16241.675166496603, 16272.83727162737, 16303.510894673178, 16303.91848040776, 16341.26464309109, 7276.745313913988, 7628.389728821792, 7658.119316278588, 7757.301842834172, 7790.610469476504, 6846.315368463114, 7045.68294426752, 7129.500934934608, 7163.570185788765, 7166.820829479305, 7031.683574239171, 7096.126068942087, 7099.82250443743, 7148.571085734872, 7171.354578087997, 2105.273680580228, 2112.6936594193758, 2128.936131916045, 2170.6852506386485, 2276.3853759484846, 746.7050515046635, 766.4558163703721, 766.9654865531064, 776.111352501394, 787.3858390455454, 14616.780748288784, 14674.926625366805, 14741.336639851232, 15143.848561514244, 15266.694666106616, 773.6093272897151, 774.0324594257179, 777.3431450424382, 785.8428314337156, 794.3010151067024, 7708.730194443167, 7887.526748395115, 8088.150744171895, 8158.673653053811, 8347.833043339098, 443217.0, 446243.0, 452257.0, 455300.0, 461277.0, 63154.0, 82371.5881420589, 88675.55662221777, 89060.0, 90132.54933725289, 1057.9523921423554, 1062.5431064642278, 1066.3868275741324, 1068.7274744939991, 1069.2408390043156, 12501.312427816558, 12850.67873303175, 12877.871221288042, 12983.0, 13345.266010369523, 39648.0, 40791.0, 41366.0, 41554.79222603868, 41912.0, 48653.5134648649, 49146.866369766736, 52205.47794522006, 53082.73458632682, 53599.0, 8398.874016889873, 8465.153484651486, 8617.95691021541, 8706.651733930572, 8768.95615521944, 12530.185537940004, 12609.747805044031, 12852.100352975576, 12973.286469244282, 13176.0, 10961.616343427942, 11142.888571114185, 11336.0, 11378.31730096197, 11472.655820325404, 10891.400972946563, 11112.777744444904, 11121.666350009513, 11163.888361116286, 11352.318860868374, 11118.833217501582, 11472.598459053894, 11523.8271425927, 11617.709557260798, 11975.341356225492, 8392.28665563434, 8579.313654907468, 8666.616680412937, 8681.262092722189, 8744.994325652377, 11492.195546311677, 11515.481803319039, 11532.654020379403, 11608.0, 11929.701757456132], "value": 8849.26003037514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.3760457375886, 1329.7274058817943, 1345.8384993800742, 1350.291097173984, 1350.9324533773308, 9392.62429502819, 9792.11870931616, 9801.607935682574, 9807.803843923117, 10032.54853531591, 9731.562079706413, 9918.603255869775, 9940.35387699799, 9944.254180936423, 9949.253805964545, 2166.1010680567547, 2201.9559608807895, 2211.402921211272, 2211.6682497625325, 2215.4129155773735, 2136.3590922723197, 2137.9037943292587, 2198.9994552478665, 2203.8126759225484, 2208.182972300243, 2145.635242008854, 2169.858959167657, 2192.5395666909967, 2194.2868567715477, 2194.297824696098, 2101.5376617144357, 2113.8520303578757, 2115.608612406702, 2129.2015494189754, 2130.20117455954, 1830.2861883865303, 1897.127321432129, 2055.393658870637, 2109.567538654572, 2178.986771151406, 9683.176929960962, 9801.950990245003, 9803.607855685765, 9806.852897206547, 9847.359921605073, 5321.255024296602, 5588.636738611977, 5604.607677462579, 5608.859778505529, 5614.494695477427, 3162.414953233659, 3195.792273502215, 3232.5474433579316, 3233.4826427771677, 3260.315333779909, 939.2345238630562, 940.3967578702283, 950.12588418655, 954.4941181173989, 979.5543027922349, 14400.207988560625, 14562.271886405637, 14613.050151740103, 14757.483488077865, 14790.18653974031, 4762.238041913277, 4982.501749824988, 5022.0, 5026.84919452417, 5072.4673909239, 12146.331951742563, 12197.207181533173, 12208.877911220952, 12217.205881617667, 12229.449674764479, 5501.0, 5509.173623956359, 5528.917066244009, 5532.30846144232, 5535.280413546213, 4908.3619129513645, 4946.554810067111, 5026.773795179226, 5056.064628043824, 5088.6946783193125, 3789.2232092420986, 3911.7848518331766, 3912.3349030664854, 3963.8018099095507, 3989.6608788253325, 1133.699569614053, 1140.7205234717546, 1146.5585749486509, 1157.242006485753, 1161.651504548632, 649.5972497051764, 655.9147310849559, 678.8506528563709, 680.0, 691.7544271783545, 5221.0, 5283.6037297202865, 5506.531944784738, 5605.579581531401, 5633.8309850704545, 779.1974266505508, 810.7040930060485, 811.1077814404226, 827.9006519217733, 838.4005436113086, 3484.198634314122, 3599.9820000899826, 3631.6731494165124, 3664.72514561409, 3685.8157092145284, 12666.49334026647, 12980.870191298154, 13090.541831036058, 13204.0, 13239.801402978963, 13017.414216360286, 13039.869601304055, 13040.80438793419, 13087.345632718327, 13318.800217996737, 9439.622415103457, 9459.527023648927, 9576.712698619192, 9618.567164477616, 9622.711318660451, 5416.431274716256, 5430.13117901134, 5564.276644036249, 5586.664800112007, 5642.6614403135945, 11377.658670239905, 11555.0, 11663.533458661897, 11802.468888900192, 11907.940460297643, 12136.635900922987, 12182.329971851634, 12207.45066471993, 12282.0, 12372.381380930738, 7094.219635840157, 7143.285671432815, 7169.677364518505, 7231.710731570889, 7258.782236532912, 8922.241609463268, 9011.098890110936, 9035.412698174598, 9057.637694492147, 9064.0, 7748.0, 7836.725714600189, 7874.527528348317, 8022.679092836454, 8108.351331893552, 7990.840183196187, 8117.594120294079, 8121.3908956829655, 8146.2261085196815, 8271.586420679063, 6432.324605916311, 6517.73929042833, 6606.942889137715, 6741.089952856301, 6791.320867913169, 4961.08219979305, 5007.8748031298055, 5025.422076461107, 5162.845114646567, 5176.171812509981, 5044.54599086084, 5095.13382724945, 5127.359080114986, 5130.5529153582465, 5390.110631745718], "value": 4647.931816556925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.97333186676946, 400.9037830920579, 407.78998815609964, 411.71797318836616, 416.06385632327266, 5366.382865970415, 5532.114861622146, 5570.972145139273, 5585.553155747541, 5617.8033768818095, 5380.838574842751, 5460.563154947595, 5465.699386533739, 5482.862928426792, 5497.065498865192, 4271.0, 4271.337942618899, 4280.850170244042, 4288.290628606264, 4290.377895205193, 4057.2696914555368, 4276.2516559601945, 4281.48622165339, 4288.571142885702, 4290.2706539888295, 4242.321228603424, 4243.469566304212, 4245.980964568496, 4262.850800221993, 4266.552012038738, 4255.702100852942, 4258.127083947783, 4259.787010649487, 4259.957400426003, 4262.0836520148005, 3724.7206459515646, 3746.1571146492092, 3762.0030691866677, 3762.398016317376, 3770.6229377062073, 5147.356580427447, 5348.893022139574, 5363.275957745694, 5369.067135831097, 5382.300300960889, 4836.202026665596, 4891.241857512091, 4895.877603059952, 4896.216605343164, 4917.8278760243575, 5520.475554822286, 5767.826965191051, 5775.191473193714, 5777.826665200051, 5795.652260864362, 4068.4507591475067, 4104.153131091021, 4109.6506796922295, 4116.135611521554, 4122.525909520384, 5811.302643682785, 6001.759929602811, 6018.15745795589, 6058.031139879557, 6111.297200821918, 4174.770387628649, 4176.14389050244, 4185.309423945076, 4188.434561334242, 4201.474815648044, 4273.401723758614, 4278.465191851019, 4285.121550082225, 4285.528591854956, 4289.356596510548, 4766.285057241442, 4799.688020278671, 4858.7570621468785, 4878.219484882473, 4885.145099607555, 5775.595708300379, 5788.392218816964, 5790.015697331463, 5801.187833703285, 5835.44563266489, 1465.8314293856129, 1479.4465810898514, 1479.4673917389732, 1480.2154857925316, 1482.392219190127, 953.1231267234161, 996.5748978960156, 1007.3552926127285, 1007.6322142417964, 1010.2726037253166, 5130.0, 5134.638066489382, 5145.048166089286, 5160.845174644766, 5165.71976794738, 6000.459958603747, 6044.274687037584, 6127.20346354971, 6135.202423684892, 6139.0, 4817.421909370898, 5103.87240318995, 5136.717480538607, 5137.588992880561, 5166.457521960216, 3231.919202019921, 3262.983685081607, 3264.396086723964, 3270.5094235864813, 3284.556584861061, 5459.972700136474, 5618.157276408571, 5643.576731745054, 5643.971780141073, 5668.858278542987, 6180.3201647818705, 6202.162708034358, 6208.906866397007, 6209.9068513972325, 6244.718987645567, 5586.581006424534, 5607.130894711245, 5610.691411972381, 5638.182463542763, 5640.379558248672, 5757.251557297524, 6029.638221706711, 6038.953900886504, 6047.455728984237, 6066.939330606814, 5964.105384192406, 5965.0, 5969.462748352669, 5978.760849565969, 5983.922893879144, 5327.866803329948, 5398.919016214839, 5524.889502210013, 5569.470900264469, 5626.437356264504, 4191.140816132746, 4214.62068413832, 4217.304144816071, 4226.323788193874, 4238.537704491945, 5942.227510423617, 6021.608595441282, 6041.75832966694, 6045.365236650088, 6065.663884863396, 5770.769169233352, 5826.213461182686, 5856.4143585641095, 5861.208736820475, 5864.589478736448, 5816.243888294494, 5828.300603927556, 5838.32859221195, 5858.414158584107, 5872.148538461985, 5552.722363881709, 5735.225744524436, 5740.110282905989, 5746.942530574808, 5769.91345129815, 5856.033754430471, 5872.735726892385, 5882.588218824641, 5886.175935369138, 5894.263217097863, 5488.451154884479, 5709.571782116441, 5714.828555143353, 5722.799702010576, 5757.91363129545], "value": 4389.812723427266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.9762008329709, 681.9965900170499, 686.423404340354, 712.7576623947854, 719.992011184342, 12730.809037864428, 12870.227786332827, 12941.094123411365, 13219.272939988308, 13634.386452609631, 12961.870381296185, 13216.339183040858, 13262.336883155851, 13322.067455278135, 13694.246816425093, 833.3000279765012, 851.0, 866.5797088412115, 868.2142660891872, 870.0951010948606, 847.8685803700437, 853.5390888920007, 878.8813510176109, 880.7798050487378, 884.9734507964771, 897.6185121323444, 918.228687902162, 919.3610440743686, 921.8801555797737, 927.679950417105, 916.0610374366262, 918.3892711346946, 918.728974952394, 919.5310391700215, 919.7746552094712, 671.516508114157, 675.5068799776142, 677.9864402711918, 678.352173674145, 679.6975345971044, 14456.349464274133, 14627.829773618085, 14778.03942743729, 14827.851721482755, 14883.47907823221, 13083.607491775261, 13871.722565548733, 13877.791833122512, 13898.722025559533, 14001.859981400157, 10039.29724919256, 10281.126104281146, 10412.11497022754, 10491.63279285229, 10516.158707303397, 2707.3096360428162, 2730.931726706828, 2731.3444773254473, 2814.9296267593268, 2847.686754457008, 60805.695971520305, 61242.387576124114, 62289.0, 62693.37306626967, 62898.685506572634, 10913.945430272797, 11111.0, 11137.944310278397, 11252.66242012741, 11346.48940797666, 21837.344879653636, 21857.344279671634, 21903.0, 21951.0, 22136.446588835086, 6614.107095542136, 6732.158480189976, 6743.35938085881, 6868.141482314711, 6957.026016357714, 3286.375588638151, 3369.140869078369, 3390.423627983249, 3408.5909690837257, 3458.066322093071, 3507.3686736387695, 3594.3530164570107, 3622.3989812313957, 3664.230511592542, 3677.5770786359376, 599.7031469422664, 604.127036432351, 607.696151924038, 616.4913945994573, 616.5930485879298, 428.3510481620348, 433.55127443096245, 449.67398635988644, 455.9886002849955, 457.35969642500766, 7086.787396378117, 7278.053852999076, 7336.303051210127, 7936.880946785803, 8009.839803203903, 501.27815945039026, 510.1124044163129, 528.3105547260861, 537.7472587883689, 554.0968221798523, 3596.604373518911, 3665.981670091686, 3729.8881033569037, 3847.3651847445417, 3887.8444862205197, 54064.45935540594, 55529.722351388795, 55999.72000140055, 56948.430515694316, 57347.713261433426, 48361.5163848364, 48641.0, 48768.756156218995, 49849.0, 49930.50069499331, 37678.43482347767, 38911.80544097262, 40673.59326406698, 42585.57414425878, 45137.32294015527, 8967.551622418983, 8974.19232269099, 9033.638654453749, 9038.3673142882, 9531.76170595713, 20908.082393035824, 21538.353849383915, 21590.568188635825, 24018.75981240165, 24028.0, 38279.617203827605, 42631.786841065594, 42833.357499636906, 43041.569584305005, 44095.77952110219, 11131.666050018512, 11241.71895702614, 11253.606123785628, 11551.826722599, 11930.940345298219, 10255.58977640886, 10274.33216840903, 10383.740406489898, 10546.683599492027, 10830.566777329133, 11368.261063030877, 11728.41357932117, 11779.352135632622, 12031.0, 12214.206076604993, 11177.552897883994, 11343.659690209306, 11474.885251147381, 11903.364729518797, 11944.701382465508, 10896.50965706561, 11059.668209953714, 11081.5567377304, 11146.442677866236, 11414.94292528532, 9245.67640132619, 9856.802863942537, 10089.697309080739, 10231.7442063949, 10234.053921789091, 10277.84583231267, 10703.966246413156, 10749.4201391667, 10806.13550915909, 10837.295575787864], "value": 6171.476594303329, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 111.0, 110.0, 114.0, 111.0, 111.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 131.0, 185.0, 129.0, 126.0, 123.0, 126.0, 146.0, 126.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 167.0, 176.0, 162.0, 164.0, 165.0, 167.0, 167.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 108.0, 77.0, 76.0, 76.0, 75.0, 91.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 85.0, 83.0, 83.0, 99.0, 83.0, 84.0, 110.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 152.0, 150.0, 152.0, 149.0, 149.0, 152.0, 155.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 96.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 73.0, 71.0, 70.0, 69.0, 70.0, 69.0, 73.0], "value": 70.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 87.0, 83.0, 88.0, 84.0, 83.0, 83.0, 84.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 152.0, 141.0, 135.0, 139.0, 143.0, 135.0, 140.0, 191.0, 135.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 199.0, 198.0, 198.0, 195.0, 194.0, 193.0, 200.0, 195.0, 193.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 71.0, 73.0, 71.0, 75.0, 71.0, 71.0, 72.0, 72.0], "value": 72.1, "unit": "score"}]}]} 08:58:15 INFO - Return code: 0 08:58:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:15 ERROR - # TBPL SUCCESS # 08:58:15 INFO - Running post-action listener: _resource_record_post_action 08:58:15 INFO - [mozharness: 2017-03-22 15:58:15.282504Z] Finished run-tests step (success) 08:58:15 INFO - Running post-run listener: _resource_record_post_run 08:58:15 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363851776; Read time: 12; Write time: 222392 08:58:15 INFO - TinderboxPrint: CPU usage
13.3% 08:58:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:58:15 INFO - TinderboxPrint: I/O write bytes / time
363,851,776 / 222,392 08:58:15 INFO - TinderboxPrint: CPU idle
8,315.7 (86.7%) 08:58:15 INFO - TinderboxPrint: CPU user
1,219.1 (12.7%) 08:58:15 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105967616; Read time: 0; Write time: 95644 08:58:15 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257884160; Read time: 12; Write time: 126748 08:58:15 INFO - Running post-run listener: _upload_blobber_files 08:58:15 INFO - Blob upload gear active. 08:58:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:15 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 08:58:15 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'] 08:58:15 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 08:58:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:19 INFO - (blobuploader) - INFO - Done attempting. 08:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:20 INFO - (blobuploader) - INFO - Done attempting. 08:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:21 INFO - (blobuploader) - INFO - Done attempting. 08:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:21 INFO - (blobuploader) - INFO - Done attempting. 08:58:21 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:21 INFO - Return code: 0 08:58:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d4832ff666e781c2c71c35a850309829d84d73dfc1c418cdd424ff00052584c0d2ef29ae5d4bbb6ed6dce9a7d8255631f3b8b26c1199fd10f9c25d9ebb4c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03f1037a161b40b55d234cafa62d8981a78dfb32105373a1ec12fb5a5f9e05a6eb5dcb96018430c8fd93bd5d9d81837b9507beca749b9368ede371a876ae0b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31e2ea30864a8896a49e420d694b08ef21b42a44960c7e70901eca664f3d1358b1599d8afa7a090497a06a62cf80d582d816464a1458d31a632dede0fd0cf936", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b3c8d5f5c2177da3fd8682c37b6a8fe51cfd1fcf6d1bd802d33b9e34f85418a31c41ce68320c4e0ef69e590cd15835806e49b14b3d2a8c4de1db0165b485a4"} 08:58:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:21 INFO - Contents: 08:58:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d4832ff666e781c2c71c35a850309829d84d73dfc1c418cdd424ff00052584c0d2ef29ae5d4bbb6ed6dce9a7d8255631f3b8b26c1199fd10f9c25d9ebb4c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03f1037a161b40b55d234cafa62d8981a78dfb32105373a1ec12fb5a5f9e05a6eb5dcb96018430c8fd93bd5d9d81837b9507beca749b9368ede371a876ae0b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31e2ea30864a8896a49e420d694b08ef21b42a44960c7e70901eca664f3d1358b1599d8afa7a090497a06a62cf80d582d816464a1458d31a632dede0fd0cf936", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b3c8d5f5c2177da3fd8682c37b6a8fe51cfd1fcf6d1bd802d33b9e34f85418a31c41ce68320c4e0ef69e590cd15835806e49b14b3d2a8c4de1db0165b485a4"} 08:58:21 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:21 INFO - Copying logs to upload dir... 08:58:21 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.686933 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-22 08:58:21.164742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:58:21.168723) ========= 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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 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/e9d4832ff666e781c2c71c35a850309829d84d73dfc1c418cdd424ff00052584c0d2ef29ae5d4bbb6ed6dce9a7d8255631f3b8b26c1199fd10f9c25d9ebb4c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03f1037a161b40b55d234cafa62d8981a78dfb32105373a1ec12fb5a5f9e05a6eb5dcb96018430c8fd93bd5d9d81837b9507beca749b9368ede371a876ae0b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31e2ea30864a8896a49e420d694b08ef21b42a44960c7e70901eca664f3d1358b1599d8afa7a090497a06a62cf80d582d816464a1458d31a632dede0fd0cf936", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b3c8d5f5c2177da3fd8682c37b6a8fe51cfd1fcf6d1bd802d33b9e34f85418a31c41ce68320c4e0ef69e590cd15835806e49b14b3d2a8c4de1db0165b485a4"} build_url:https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/JVct9Vz3RZCSFfI6nhmynA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d4832ff666e781c2c71c35a850309829d84d73dfc1c418cdd424ff00052584c0d2ef29ae5d4bbb6ed6dce9a7d8255631f3b8b26c1199fd10f9c25d9ebb4c3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c03f1037a161b40b55d234cafa62d8981a78dfb32105373a1ec12fb5a5f9e05a6eb5dcb96018430c8fd93bd5d9d81837b9507beca749b9368ede371a876ae0b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31e2ea30864a8896a49e420d694b08ef21b42a44960c7e70901eca664f3d1358b1599d8afa7a090497a06a62cf80d582d816464a1458d31a632dede0fd0cf936", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b3c8d5f5c2177da3fd8682c37b6a8fe51cfd1fcf6d1bd802d33b9e34f85418a31c41ce68320c4e0ef69e590cd15835806e49b14b3d2a8c4de1db0165b485a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:58:21.193924) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:58:21.194290) ========= 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=dac658600622fd96716c9acf000001b3-1490197040.93636-1790274431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:58:21.278240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:58:21.278577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:58:21.278929) ========= ========= Total master_lag: 0.16 =========