builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-078 starttime: 1490494318.9 results: success (0) revision: d57834d60548d3003d8c0725e7b0f103c1346da3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.903049) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.903545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.903836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.925899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.926256) ========= 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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-25 19:11:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-03-25 19:11:59 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118905 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.059640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.059961) ========= 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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.109218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.109595) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d57834d60548d3003d8c0725e7b0f103c1346da3 --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 d57834d60548d3003d8c0725e7b0f103c1346da3 --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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-25 19:12:00,037 truncating revision to first 12 chars 2017-03-25 19:12:00,037 Setting DEBUG logging. 2017-03-25 19:12:00,037 attempt 1/10 2017-03-25 19:12:00,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d57834d60548?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 19:12:00,382 unpacking tar archive at: mozilla-central-d57834d60548/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.837939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.838250) ========= script_repo_revision: d57834d60548d3003d8c0725e7b0f103c1346da3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.838639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.838946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.848038) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-25 19:11:59.848408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:00 INFO - MultiFileLogger online at 20170325 19:12:00 in /builds/slave/test 19:12:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 19:12:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:00 INFO - {'append_to_log': False, 19:12:00 INFO - 'base_work_dir': '/builds/slave/test', 19:12:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:12:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:00 INFO - 'branch': 'Firefox-Non-PGO', 19:12:00 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:00 INFO - 'config_files': ('talos/linux_config.py',), 19:12:00 INFO - 'default_actions': ('clobber', 19:12:00 INFO - 'read-buildbot-config', 19:12:00 INFO - 'download-and-extract', 19:12:00 INFO - 'populate-webroot', 19:12:00 INFO - 'create-virtualenv', 19:12:00 INFO - 'install', 19:12:00 INFO - 'run-tests'), 19:12:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:00 INFO - 'download_minidump_stackwalk': True, 19:12:00 INFO - 'download_symbols': 'ondemand', 19:12:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:00 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:00 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:00 INFO - 'gecko_profile': False, 19:12:00 INFO - 'gecko_profile_interval': 0, 19:12:00 INFO - 'installer_path': 'installer.exe', 19:12:00 INFO - 'log_level': 'info', 19:12:00 INFO - 'log_name': 'talos', 19:12:00 INFO - 'log_to_console': True, 19:12:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:00 INFO - 'opt_config_files': (), 19:12:00 INFO - 'pip_index': False, 19:12:00 INFO - 'suite': 'dromaeojs', 19:12:00 INFO - 'system_bits': '32', 19:12:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:00 INFO - 'title': 'talos-linux64-ix-078', 19:12:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:00 INFO - 'use_talos_json': True, 19:12:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:00 INFO - 'work_dir': 'build'} 19:12:00 INFO - [mozharness: 2017-03-26 02:12:00.870426Z] Running clobber step. 19:12:00 INFO - Running pre-action listener: _resource_record_pre_action 19:12:00 INFO - Running main action method: clobber 19:12:00 INFO - rmtree: /builds/slave/test/build 19:12:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:02 INFO - Running post-action listener: _resource_record_post_action 19:12:02 INFO - [mozharness: 2017-03-26 02:12:02.313408Z] Finished clobber step (success) 19:12:02 INFO - [mozharness: 2017-03-26 02:12:02.313518Z] Running read-buildbot-config step. 19:12:02 INFO - Running pre-action listener: _resource_record_pre_action 19:12:02 INFO - Running main action method: read_buildbot_config 19:12:02 INFO - Using buildbot properties: 19:12:02 INFO - { 19:12:02 INFO - "project": "", 19:12:02 INFO - "product": "firefox", 19:12:02 INFO - "who": "philringnalda@gmail.com", 19:12:02 INFO - "installer_path": "public/build/target.tar.bz2", 19:12:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:12:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:12:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 19:12:02 INFO - "stage_platform": "linux64", 19:12:02 INFO - "basedir": "/builds/slave/test", 19:12:02 INFO - "buildnumber": 513, 19:12:02 INFO - "platform": "ubuntu64_hw", 19:12:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:12:02 INFO - "slavebuilddir": "test", 19:12:02 INFO - "taskId": "UNczPm_CSEKniZwwWd9iWA", 19:12:02 INFO - "branch": "mozilla-central", 19:12:02 INFO - "script_repo_revision": "production", 19:12:02 INFO - "revision": "d57834d60548d3003d8c0725e7b0f103c1346da3", 19:12:02 INFO - "slavename": "talos-linux64-ix-078", 19:12:02 INFO - "repo_path": "mozilla-central" 19:12:02 INFO - } 19:12:02 INFO - Finding installer, test and symbols from parent task. 19:12:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNczPm_CSEKniZwwWd9iWA'}, attempt #1 19:12:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNczPm_CSEKniZwwWd9iWA'}, attempt #1 19:12:03 INFO - Task dependencies: aUKtNe-LRZ-9XMJQTLAWjg 19:12:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg'}, attempt #1 19:12:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/test_packages.json 19:12:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.crashreporter-symbols.zip 19:12:03 INFO - Running post-action listener: _resource_record_post_action 19:12:03 INFO - [mozharness: 2017-03-26 02:12:03.790624Z] Finished read-buildbot-config step (success) 19:12:03 INFO - [mozharness: 2017-03-26 02:12:03.790844Z] Running download-and-extract step. 19:12:03 INFO - Running pre-action listener: _resource_record_pre_action 19:12:03 INFO - Running main action method: download_and_extract 19:12:03 INFO - mkdir: /builds/slave/test/build/tests 19:12:03 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')]} 19:12:03 INFO - trying https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json 19:12:03 INFO - Downloading https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:12:04 INFO - Downloaded 986 bytes. 19:12:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:12:04 INFO - Using the following test package requirements: 19:12:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:12:04 INFO - u'common': [u'target.common.tests.zip'], 19:12:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:12:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:12:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:12:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:12:04 INFO - u'mozbase': [u'target.common.tests.zip'], 19:12:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:12:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:12:04 INFO - u'web-platform': [u'target.common.tests.zip', 19:12:04 INFO - u'target.web-platform.tests.zip'], 19:12:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:12:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:12:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip 19:12:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:04 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip into memory 19:12:05 INFO - Expected file size: 58128617 19:12:05 INFO - Obtained file size: 58128617 19:12:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip 19:12:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:15 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip into memory 19:12:16 INFO - Expected file size: 58128617 19:12:16 INFO - Obtained file size: 58128617 19:12:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip 19:12:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:12:27 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip into memory 19:12:27 INFO - Expected file size: 14404171 19:12:27 INFO - Obtained file size: 14404171 19:12: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')]} 19:12:28 INFO - trying https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:12:30 INFO - Downloaded 62578384 bytes. 19:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:30 INFO - mkdir: /builds/slave/test/properties 19:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:30 INFO - Contents: 19:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:30 INFO - Running post-action listener: _resource_record_post_action 19:12:30 INFO - Running post-action listener: set_extra_try_arguments 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.003867Z] Finished download-and-extract step (success) 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.003963Z] Running populate-webroot step. 19:12:30 INFO - Running pre-action listener: _resource_record_pre_action 19:12:30 INFO - Running main action method: populate_webroot 19:12:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:30 INFO - '--tppagecycles', 19:12:30 INFO - '7'], 19:12:30 INFO - 'tests': ['tsvgm']}}, 19:12:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['damp', 'tps']}, 19:12:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'tests': ['damp', 'tps']}, 19:12:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['dromaeo_dom']}, 19:12:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['basic_compositor_video']}, 19:12:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:12:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tsvgx', 19:12:30 INFO - 'tsvgr_opacity', 19:12:30 INFO - 'tart', 19:12:30 INFO - 'tscrollx', 19:12:30 INFO - 'cart', 19:12:30 INFO - 'tsvg_static']}, 19:12:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:30 INFO - 'tsvgr_opacity', 19:12:30 INFO - 'tart', 19:12:30 INFO - 'tscrollx', 19:12:30 INFO - 'cart', 19:12:30 INFO - 'tsvg_static']}, 19:12:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tp5o']}, 19:12:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:12:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s', 19:12:30 INFO - '--xperf_path', 19:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:30 INFO - 'tests': ['tp5n']}, 19:12:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--xperf_path', 19:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:30 INFO - 'tests': ['tp5n']}}, 19:12:30 INFO - 'talos.zip': {'path': '', 19:12:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:30 INFO - Running post-action listener: _resource_record_post_action 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.017083Z] Finished populate-webroot step (success) 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.017172Z] Running create-virtualenv step. 19:12:30 INFO - Running pre-action listener: _resource_record_pre_action 19:12:30 INFO - Running main action method: create_virtualenv 19:12:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:30 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 19:12:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:30 INFO - Using real prefix '/usr' 19:12:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:12:32 INFO - Installing pip.................done. 19:12:32 INFO - Return code: 0 19:12:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:12:32 INFO - Reading from file tmpfile_stdout 19:12:32 INFO - Output received: 19:12:32 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) 19:12:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:12:32 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')]} 19:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:32 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')]} 19:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:32 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:32 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 19:12:32 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 19:12:32 INFO - Using env: {'DISPLAY': ':0', 19:12:32 INFO - 'HOME': '/home/cltbld', 19:12:32 INFO - 'LANG': 'en_US.UTF-8', 19:12:32 INFO - 'LANGUAGE': 'en_US:en', 19:12:32 INFO - 'LOGNAME': 'cltbld', 19:12:32 INFO - 'MAIL': '/var/mail/cltbld', 19:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:32 INFO - 'MOZ_NO_REMOTE': '1', 19:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:32 INFO - 'NO_EM_RESTART': '1', 19:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:32 INFO - 'PWD': '/builds/slave/test', 19:12:32 INFO - 'SHELL': '/bin/bash', 19:12:32 INFO - 'SHLVL': '1', 19:12:32 INFO - 'TERM': 'linux', 19:12:32 INFO - 'TMOUT': '86400', 19:12:32 INFO - 'USER': 'cltbld', 19:12:32 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:32 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 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 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:33 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 19:12:33 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 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Downloading/unpacking psutil>=3.1.1 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:12:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:35 INFO - Installing collected packages: psutil 19:12:35 INFO - Running setup.py install for psutil 19:12:35 INFO - building 'psutil._psutil_linux' extension 19:12:35 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 19:12:35 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 19:12:35 INFO - building 'psutil._psutil_posix' extension 19:12:35 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 19:12:35 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 19:12:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:35 INFO - Successfully installed psutil 19:12:35 INFO - Cleaning up... 19:12:35 INFO - Return code: 0 19:12:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:35 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:35 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 19:12:35 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 19:12:35 INFO - Using env: {'DISPLAY': ':0', 19:12:35 INFO - 'HOME': '/home/cltbld', 19:12:35 INFO - 'LANG': 'en_US.UTF-8', 19:12:35 INFO - 'LANGUAGE': 'en_US:en', 19:12:35 INFO - 'LOGNAME': 'cltbld', 19:12:35 INFO - 'MAIL': '/var/mail/cltbld', 19:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:35 INFO - 'MOZ_NO_REMOTE': '1', 19:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:35 INFO - 'NO_EM_RESTART': '1', 19:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:35 INFO - 'PWD': '/builds/slave/test', 19:12:35 INFO - 'SHELL': '/bin/bash', 19:12:35 INFO - 'SHLVL': '1', 19:12:35 INFO - 'TERM': 'linux', 19:12:35 INFO - 'TMOUT': '86400', 19:12:35 INFO - 'USER': 'cltbld', 19:12:35 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:35 INFO - '_': '/tools/buildbot/bin/python'} 19:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:38 INFO - Installing collected packages: mozsystemmonitor 19:12:38 INFO - Running setup.py install for mozsystemmonitor 19:12:38 INFO - Successfully installed mozsystemmonitor 19:12:38 INFO - Cleaning up... 19:12:38 INFO - Return code: 0 19:12:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12:38 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')]} 19:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:38 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')]} 19:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:38 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:38 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 19:12:38 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 19:12:38 INFO - Using env: {'DISPLAY': ':0', 19:12:38 INFO - 'HOME': '/home/cltbld', 19:12:38 INFO - 'LANG': 'en_US.UTF-8', 19:12:38 INFO - 'LANGUAGE': 'en_US:en', 19:12:38 INFO - 'LOGNAME': 'cltbld', 19:12:38 INFO - 'MAIL': '/var/mail/cltbld', 19:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:38 INFO - 'MOZ_NO_REMOTE': '1', 19:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:38 INFO - 'NO_EM_RESTART': '1', 19:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:38 INFO - 'PWD': '/builds/slave/test', 19:12:38 INFO - 'SHELL': '/bin/bash', 19:12:38 INFO - 'SHLVL': '1', 19:12:38 INFO - 'TERM': 'linux', 19:12:38 INFO - 'TMOUT': '86400', 19:12:38 INFO - 'USER': 'cltbld', 19:12:38 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:38 INFO - '_': '/tools/buildbot/bin/python'} 19:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:38 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12:40 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 19:12:40 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 19:12:40 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 19:12:40 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 19:12:40 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 19:12:40 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 19:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:40 INFO - warning: no files found matching '*.txt' 19:12:40 INFO - no previously-included directories found matching 'build' 19:12:40 INFO - no previously-included directories found matching 'dist' 19:12:40 INFO - no previously-included directories found matching '.git*' 19:12:40 INFO - Installing collected packages: jsonschema, functools32 19:12:40 INFO - Running setup.py install for functools32 19:12:40 INFO - warning: no files found matching '*.txt' 19:12:40 INFO - no previously-included directories found matching 'build' 19:12:40 INFO - no previously-included directories found matching 'dist' 19:12:40 INFO - no previously-included directories found matching '.git*' 19:12:41 INFO - Successfully installed jsonschema functools32 19:12:41 INFO - Cleaning up... 19:12:41 INFO - Return code: 0 19:12:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:12:41 INFO - Using env: {'DISPLAY': ':0', 19:12:41 INFO - 'HOME': '/home/cltbld', 19:12:41 INFO - 'LANG': 'en_US.UTF-8', 19:12:41 INFO - 'LANGUAGE': 'en_US:en', 19:12:41 INFO - 'LOGNAME': 'cltbld', 19:12:41 INFO - 'MAIL': '/var/mail/cltbld', 19:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:41 INFO - 'MOZ_NO_REMOTE': '1', 19:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:41 INFO - 'NO_EM_RESTART': '1', 19:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:41 INFO - 'PWD': '/builds/slave/test', 19:12:41 INFO - 'SHELL': '/bin/bash', 19:12:41 INFO - 'SHLVL': '1', 19:12:41 INFO - 'TERM': 'linux', 19:12:41 INFO - 'TMOUT': '86400', 19:12:41 INFO - 'USER': 'cltbld', 19:12:41 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:41 INFO - '_': '/tools/buildbot/bin/python'} 19:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:41 INFO - Cleaning up... 19:12:41 INFO - Return code: 0 19:12:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:12:41 INFO - Using env: {'DISPLAY': ':0', 19:12:41 INFO - 'HOME': '/home/cltbld', 19:12:41 INFO - 'LANG': 'en_US.UTF-8', 19:12:41 INFO - 'LANGUAGE': 'en_US:en', 19:12:41 INFO - 'LOGNAME': 'cltbld', 19:12:41 INFO - 'MAIL': '/var/mail/cltbld', 19:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:41 INFO - 'MOZ_NO_REMOTE': '1', 19:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:41 INFO - 'NO_EM_RESTART': '1', 19:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:41 INFO - 'PWD': '/builds/slave/test', 19:12:41 INFO - 'SHELL': '/bin/bash', 19:12:41 INFO - 'SHLVL': '1', 19:12:41 INFO - 'TERM': 'linux', 19:12:41 INFO - 'TMOUT': '86400', 19:12:41 INFO - 'USER': 'cltbld', 19:12:41 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:41 INFO - '_': '/tools/buildbot/bin/python'} 19:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:41 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:41 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 19:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12:43 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 19:12:43 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 19:12:43 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 19:12:43 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 19:12:43 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 19:12:43 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 19:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:44 INFO - Downloading docopt-0.6.1.tar.gz 19:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:44 INFO - Running setup.py install for blobuploader 19:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:44 INFO - Running setup.py install for requests 19:12:44 INFO - Running setup.py install for docopt 19:12:44 INFO - Successfully installed blobuploader requests docopt 19:12:44 INFO - Cleaning up... 19:12:44 INFO - Return code: 0 19:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:44 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:44 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 19:12:44 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 19:12:44 INFO - Using env: {'DISPLAY': ':0', 19:12:44 INFO - 'HOME': '/home/cltbld', 19:12:44 INFO - 'LANG': 'en_US.UTF-8', 19:12:44 INFO - 'LANGUAGE': 'en_US:en', 19:12:44 INFO - 'LOGNAME': 'cltbld', 19:12:44 INFO - 'MAIL': '/var/mail/cltbld', 19:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:44 INFO - 'MOZ_NO_REMOTE': '1', 19:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:44 INFO - 'NO_EM_RESTART': '1', 19:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:44 INFO - 'PWD': '/builds/slave/test', 19:12:44 INFO - 'SHELL': '/bin/bash', 19:12:44 INFO - 'SHLVL': '1', 19:12:44 INFO - 'TERM': 'linux', 19:12:44 INFO - 'TMOUT': '86400', 19:12:44 INFO - 'USER': 'cltbld', 19:12:44 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:44 INFO - '_': '/tools/buildbot/bin/python'} 19:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:45 INFO - Running setup.py (path:/tmp/pip-YQyMLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:45 INFO - Running setup.py (path:/tmp/pip-VXI4K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:45 INFO - Running setup.py (path:/tmp/pip-516BaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:45 INFO - Running setup.py (path:/tmp/pip-V8Juw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:45 INFO - Running setup.py (path:/tmp/pip-mKUMPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:45 INFO - Running setup.py (path:/tmp/pip-SWlKKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:45 INFO - Running setup.py (path:/tmp/pip-CtbCL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:45 INFO - Running setup.py (path:/tmp/pip-SJ2lCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:45 INFO - Running setup.py (path:/tmp/pip-f3S2hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:45 INFO - Running setup.py (path:/tmp/pip-rxOzsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:45 INFO - Running setup.py (path:/tmp/pip-Maa9IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:45 INFO - Running setup.py (path:/tmp/pip-mRvigD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:46 INFO - Running setup.py (path:/tmp/pip-1dOU49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:46 INFO - Running setup.py (path:/tmp/pip-l0WiXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:46 INFO - Running setup.py (path:/tmp/pip-l4n7sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:46 INFO - Running setup.py (path:/tmp/pip-KiKdFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:46 INFO - Running setup.py (path:/tmp/pip-zmMuS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:46 INFO - Running setup.py install for manifestparser 19:12:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:46 INFO - Running setup.py install for mozcrash 19:12:46 INFO - Running setup.py install for mozdebug 19:12:46 INFO - Running setup.py install for mozdevice 19:12:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:46 INFO - Running setup.py install for mozfile 19:12:46 INFO - Running setup.py install for mozhttpd 19:12:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:46 INFO - Running setup.py install for mozinfo 19:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozInstall 19:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozleak 19:12:47 INFO - Running setup.py install for mozlog 19:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for moznetwork 19:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozprocess 19:12:47 INFO - Running setup.py install for mozprofile 19:12:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozrunner 19:12:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozscreenshot 19:12:47 INFO - Running setup.py install for moztest 19:12:48 INFO - Running setup.py install for mozversion 19:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:48 INFO - Cleaning up... 19:12:48 INFO - Return code: 0 19:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:48 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')]} 19:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:48 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')]} 19:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:48 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:48 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 19:12:48 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 19:12:48 INFO - Using env: {'DISPLAY': ':0', 19:12:48 INFO - 'HOME': '/home/cltbld', 19:12:48 INFO - 'LANG': 'en_US.UTF-8', 19:12:48 INFO - 'LANGUAGE': 'en_US:en', 19:12:48 INFO - 'LOGNAME': 'cltbld', 19:12:48 INFO - 'MAIL': '/var/mail/cltbld', 19:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:48 INFO - 'MOZ_NO_REMOTE': '1', 19:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:48 INFO - 'NO_EM_RESTART': '1', 19:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:48 INFO - 'PWD': '/builds/slave/test', 19:12:48 INFO - 'SHELL': '/bin/bash', 19:12:48 INFO - 'SHLVL': '1', 19:12:48 INFO - 'TERM': 'linux', 19:12:48 INFO - 'TMOUT': '86400', 19:12:48 INFO - 'USER': 'cltbld', 19:12:48 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:48 INFO - '_': '/tools/buildbot/bin/python'} 19:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:48 INFO - Running setup.py (path:/tmp/pip-UAyrgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:48 INFO - Running setup.py (path:/tmp/pip-IaWM3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:48 INFO - Running setup.py (path:/tmp/pip-dziPjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:48 INFO - Running setup.py (path:/tmp/pip-dAo0V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:48 INFO - Running setup.py (path:/tmp/pip-wmjMo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:48 INFO - Running setup.py (path:/tmp/pip-2z7Xpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:48 INFO - Running setup.py (path:/tmp/pip-SMtU3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:48 INFO - Running setup.py (path:/tmp/pip-QO7fiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:48 INFO - Running setup.py (path:/tmp/pip-13ESta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:49 INFO - Running setup.py (path:/tmp/pip-voS1aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:49 INFO - Running setup.py (path:/tmp/pip-delcVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:49 INFO - Running setup.py (path:/tmp/pip-AnyfeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:49 INFO - Running setup.py (path:/tmp/pip-cRmlvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:49 INFO - Running setup.py (path:/tmp/pip-V1Jhd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:49 INFO - Running setup.py (path:/tmp/pip-Txl2is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:49 INFO - Running setup.py (path:/tmp/pip-oRpQ9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:49 INFO - Running setup.py (path:/tmp/pip-gi_u9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 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)) 19:12:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:51 INFO - Downloading blessings-1.6.tar.gz 19:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:51 INFO - Installing collected packages: blessings 19:12:51 INFO - Running setup.py install for blessings 19:12:51 INFO - Successfully installed blessings 19:12:51 INFO - Cleaning up... 19:12:51 INFO - Return code: 0 19:12:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:52 INFO - Reading from file tmpfile_stdout 19:12:52 INFO - Current package versions: 19:12:52 INFO - argparse == 1.2.1 19:12:52 INFO - blessings == 1.6 19:12:52 INFO - blobuploader == 1.2.4 19:12:52 INFO - docopt == 0.6.1 19:12:52 INFO - functools32 == 3.2.3-2 19:12:52 INFO - jsonschema == 2.5.1 19:12:52 INFO - manifestparser == 1.1 19:12:52 INFO - mozInstall == 1.12 19:12:52 INFO - mozcrash == 1.0 19:12:52 INFO - mozdebug == 0.1 19:12:52 INFO - mozdevice == 0.49 19:12:52 INFO - mozfile == 1.2 19:12:52 INFO - mozhttpd == 0.7 19:12:52 INFO - mozinfo == 0.9 19:12:52 INFO - mozleak == 0.1 19:12:52 INFO - mozlog == 3.4 19:12:52 INFO - moznetwork == 0.27 19:12:52 INFO - mozprocess == 0.25 19:12:52 INFO - mozprofile == 0.28 19:12:52 INFO - mozrunner == 6.13 19:12:52 INFO - mozscreenshot == 0.1 19:12:52 INFO - mozsystemmonitor == 0.3 19:12:52 INFO - moztest == 0.8 19:12:52 INFO - mozversion == 1.4 19:12:52 INFO - psutil == 3.1.1 19:12:52 INFO - requests == 1.2.3 19:12:52 INFO - wsgiref == 0.1.2 19:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:52 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:52 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 19:12:52 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 19:12:52 INFO - Using env: {'DISPLAY': ':0', 19:12:52 INFO - 'HOME': '/home/cltbld', 19:12:52 INFO - 'LANG': 'en_US.UTF-8', 19:12:52 INFO - 'LANGUAGE': 'en_US:en', 19:12:52 INFO - 'LOGNAME': 'cltbld', 19:12:52 INFO - 'MAIL': '/var/mail/cltbld', 19:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:52 INFO - 'MOZ_NO_REMOTE': '1', 19:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:52 INFO - 'NO_EM_RESTART': '1', 19:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:52 INFO - 'PWD': '/builds/slave/test', 19:12:52 INFO - 'SHELL': '/bin/bash', 19:12:52 INFO - 'SHLVL': '1', 19:12:52 INFO - 'TERM': 'linux', 19:12:52 INFO - 'TMOUT': '86400', 19:12:52 INFO - 'USER': 'cltbld', 19:12:52 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:52 INFO - '_': '/tools/buildbot/bin/python'} 19:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 INFO - Cleaning up... 19:12:52 INFO - Return code: 0 19:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:52 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 0x23a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2641b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, '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-1490476293.496195-1357241158', '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 19:12:52 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 19:12:52 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 19:12:52 INFO - Using env: {'DISPLAY': ':0', 19:12:52 INFO - 'HOME': '/home/cltbld', 19:12:52 INFO - 'LANG': 'en_US.UTF-8', 19:12:52 INFO - 'LANGUAGE': 'en_US:en', 19:12:52 INFO - 'LOGNAME': 'cltbld', 19:12:52 INFO - 'MAIL': '/var/mail/cltbld', 19:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:52 INFO - 'MOZ_NO_REMOTE': '1', 19:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:52 INFO - 'NO_EM_RESTART': '1', 19:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:52 INFO - 'PWD': '/builds/slave/test', 19:12:52 INFO - 'SHELL': '/bin/bash', 19:12:52 INFO - 'SHLVL': '1', 19:12:52 INFO - 'TERM': 'linux', 19:12:52 INFO - 'TMOUT': '86400', 19:12:52 INFO - 'USER': 'cltbld', 19:12:52 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:52 INFO - '_': '/tools/buildbot/bin/python'} 19:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:52 INFO - Cleaning up... 19:12:52 INFO - Return code: 0 19:12:52 INFO - Running post-action listener: _resource_record_post_action 19:12:52 INFO - Running post-action listener: _start_resource_monitoring 19:12:52 INFO - Starting resource monitoring. 19:12:52 INFO - [mozharness: 2017-03-26 02:12:52.573749Z] Finished create-virtualenv step (success) 19:12:52 INFO - [mozharness: 2017-03-26 02:12:52.574261Z] Running install step. 19:12:52 INFO - Running pre-action listener: _resource_record_pre_action 19:12:52 INFO - Running main action method: install 19:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:52 INFO - Reading from file tmpfile_stdout 19:12:52 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:52 INFO - Reading from file tmpfile_stdout 19:12:52 INFO - Output received: 19:12:52 INFO - Usage: mozinstall [options] installer 19:12:52 INFO - Options: 19:12:52 INFO - -h, --help show this help message and exit 19:12:52 INFO - -d DEST, --destination=DEST 19:12:52 INFO - Directory to install application into. [default: 19:12:52 INFO - "/builds/slave/test"] 19:12:52 INFO - --app=APP Application being installed. [default: firefox] 19:12:52 INFO - mkdir: /builds/slave/test/build/application 19:12:52 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'] 19:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:13:08 INFO - Reading from file tmpfile_stdout 19:13:08 INFO - Output received: 19:13:08 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:08 INFO - Running post-action listener: _resource_record_post_action 19:13:08 INFO - [mozharness: 2017-03-26 02:13:08.557106Z] Finished install step (success) 19:13:08 INFO - [mozharness: 2017-03-26 02:13:08.557384Z] Running run-tests step. 19:13:08 INFO - Running pre-action listener: _resource_record_pre_action 19:13:08 INFO - Running main action method: run_tests 19:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:08 INFO - Python 2.7.3 19:13:08 INFO - Return code: 0 19:13:08 INFO - grabbing minidump binary from tooltool 19:13: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')]} 19:13:08 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 0x263f290>, '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 0x263fb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2640040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:08 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 19:13:08 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 19:13:08 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 19:13:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:08 INFO - Return code: 0 19:13:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:08 INFO - ENV: RUST_BACKTRACE is now 1 19:13:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:13:08 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:13:08 INFO - Using env: {'DISPLAY': ':0', 19:13:08 INFO - 'HOME': '/home/cltbld', 19:13:08 INFO - 'LANG': 'en_US.UTF-8', 19:13:08 INFO - 'LANGUAGE': 'en_US:en', 19:13:08 INFO - 'LOGNAME': 'cltbld', 19:13:08 INFO - 'MAIL': '/var/mail/cltbld', 19:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:08 INFO - 'MOZ_NO_REMOTE': '1', 19:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:08 INFO - 'NO_EM_RESTART': '1', 19:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:08 INFO - 'PWD': '/builds/slave/test', 19:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:08 INFO - 'RUST_BACKTRACE': '1', 19:13:08 INFO - 'SHELL': '/bin/bash', 19:13:08 INFO - 'SHLVL': '1', 19:13:08 INFO - 'TERM': 'linux', 19:13:08 INFO - 'TMOUT': '86400', 19:13:08 INFO - 'USER': 'cltbld', 19:13:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1490476293.496195-1357241158', 19:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:08 INFO - '_': '/tools/buildbot/bin/python'} 19:13:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:13:08 INFO - mozversion application_buildid: 20170326013901 19:13:08 INFO - mozversion application_changeset: d57834d60548d3003d8c0725e7b0f103c1346da3 19:13:08 INFO - mozversion application_display_name: Nightly 19:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:08 INFO - mozversion application_name: Firefox 19:13:08 INFO - mozversion application_remotingname: firefox 19:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:13:08 INFO - mozversion application_vendor: Mozilla 19:13:08 INFO - mozversion application_version: 55.0a1 19:13:08 INFO - mozversion platform_buildid: 20170326013901 19:13:08 INFO - mozversion platform_changeset: d57834d60548d3003d8c0725e7b0f103c1346da3 19:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:13:08 INFO - mozversion platform_version: 55.0a1 19:13:08 INFO - using testdate: 1490494388 19:13:08 INFO - actual date: 1490494388 19:13:08 INFO - starting webserver on 'localhost:49678' 19:13:08 INFO - SUITE-START | Running 2 tests 19:13:08 INFO - TEST-START | dromaeo_css 19:13:08 INFO - operating with platform_type : linux_ 19:13:08 INFO - Initialising browser for dromaeo_css test... 19:13:08 INFO - TEST-INFO | started process 22603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHE5Qf1/profile http://localhost:49678/getInfo.html) 19:13:12 INFO - PID 22603 | __metrics Screen width/height:1600/1200 19:13:12 INFO - PID 22603 | colorDepth:24 19:13:12 INFO - PID 22603 | Browser inner width/height: 1024/697 19:13:12 INFO - PID 22603 | __metrics 19:13:13 ERROR - PID 22603 | 1490494393837 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 19:13:13 INFO - PID 22603 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:13:13 INFO - PID 22603 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:13:14 INFO - TEST-INFO | 22603: exit 0 19:13:14 INFO - Browser initialized. 19:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:14 INFO - TEST-INFO | started process 22693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHE5Qf1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:27 INFO - PID 22693 | RSS: Main: 149688320 19:13:27 INFO - PID 22693 | 19:16:33 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49678/tests/dromaeo/cssquery-ext.html) 19:16:35 INFO - PID 22693 | RSS: Main: 244228096 19:16:35 INFO - PID 22693 | 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | A coding exception was thrown and uncaught in a Task. 19:18:17 INFO - PID 22693 | 19:18:17 ERROR - PID 22693 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:17 INFO - PID 22693 | Full stack: 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | A coding exception was thrown and uncaught in a Task. 19:18:17 INFO - PID 22693 | 19:18:17 ERROR - PID 22693 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:17 INFO - PID 22693 | Full stack: 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | A coding exception was thrown and uncaught in a Task. 19:18:17 INFO - PID 22693 | 19:18:17 ERROR - PID 22693 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:17 INFO - PID 22693 | Full stack: 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | ************************* 19:18:17 INFO - PID 22693 | A coding exception was thrown and uncaught in a Task. 19:18:17 INFO - PID 22693 | 19:18:17 ERROR - PID 22693 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:17 INFO - PID 22693 | Full stack: 19:18:17 INFO - PID 22693 | ************************* 19:19:37 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-ext.html (next: http://localhost:49678/tests/dromaeo/cssquery-jquery.html) 19:19:38 INFO - PID 22693 | RSS: Main: 229527552 19:19:38 INFO - PID 22693 | 19:22:40 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49678/tests/dromaeo/cssquery-mootools.html) 19:22:41 INFO - PID 22693 | RSS: Main: 220835840 19:22:41 INFO - PID 22693 | 19:25:43 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49678/tests/dromaeo/cssquery-prototype.html) 19:25:44 INFO - PID 22693 | RSS: Main: 227364864 19:25:44 INFO - PID 22693 | 19:28:47 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49678/tests/dromaeo/cssquery-yui.html) 19:28:48 INFO - PID 22693 | RSS: Main: 183218176 19:28:48 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | Cycle 1(1): loaded http://localhost:49678/tests/dromaeo/cssquery-yui.html (next: http://localhost:49678/tests/dromaeo/cssquery-dojo.html) 19:31:51 INFO - PID 22693 | RSS: Main: 274329600 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | __start_tp_report 19:31:51 INFO - PID 22693 | _x_x_mozilla_page_load 19:31:51 INFO - PID 22693 | _x_x_mozilla_page_load_details 19:31:51 INFO - PID 22693 | |i|pagename|runs| 19:31:51 INFO - PID 22693 | |0;dojo.html;2696.5550684137115;2724.550449175886;2756.2144788735213;2763.157237042701;2768.972310276897;5065.544101030907;5101.591872650189;5253.028189784888;5263.184206447997;5267.55225805806;5210.895782084356;5216.374035115791;5246.108161612526;5282.867928301795;5283.233931079991;4682.461516925563;4722.362481065046;4757.310190022454;4862.465128835825;4905.75471226439;4815.422149342101;4819.493953134923;4819.686720363183;4854.296127061574;4921.950780492203;4661.86014419568;4684.95315046852;4701.529847015271;4775.737334446604;4791.329213910055;4745.477997420316;4748.833790817304;4751.619870410359;4813.446453657839;4836.709797412132;4687.414073240845;4719.834805781816;4746.715197088151;4764.69029513084;4794.880127996793;5026.773795179226;5069.138246498104;5070.239464080418;5178.974105129488;5190.4550022247495;5585.329760428734;5599.216109744639;5643.774249030034;5644.8306550803545;5651.2935883014625;5680.517156041741;5685.260916080924;5696.3733989261145;5701;5704.71476426177;5131.25596788471;5231.346081739783;5233.895322093536;5246.947530524722;5292.841214763564;5648.350439699405;5673.234113394639;5702.885942281131;5704.030314846486;5706.3152421709665;5443.646162999472;5533.170024496278;5539.750711217925;5573.331200255914;5573.442655734394;5617.634853734494;5631.943680563224;5631.971840140855;5632.85917852057;5636.098224284095;5572.136318870582;5590.720463976785;5598.468145526169;5599.8880022400135;5603.2435621191435;5398.406175320712;5418;5429.022775900376;5457.781688732406;5553.50018498329;4686.531346865286;4688.367070445514;4708.458527269408;4732.858014259577;4737.928931066037;4006.899827504336;4011.478507793968;4014.4781178447197;4046.4132700758814;4050.9392359114636;4631.374764406762;4682.578567928835;4769.070031343924;4786.138495070851;4829.13075646387;5566.387697353288;5670.489655930986;5702.914456283159;5707.172459993278;5711.971440142773;4690.624750019991;4729.361536192639;4733.053389322149;4734.692245004064;4776.832810851603;4985;4993.50064993505;5000.874978125648;5004.149294619923;5039.647224694236;5075.695458272516;5138.743062846917;5140.922886156636;5248.947510524846;5306.044911915892;5691.77232910679;5708.143778433268;5717.37108918027;5718.485336319751;5720.456556627114;5239.947600523946;5278.419373868948;5292.206169074516;5340.172273297645;5344.5991550634635;5506.311711036121;5560.944390556043;5561.416051314553;5563.471470210324;5614.1017437211485;5429.972850135882;5512.3385193777;5530.861728456821;5625.971870140623;5652.519535839499;5351.3043304370185;5475.5072043516275;5482.39693633708;5521.696306703009;5531.280933478622;5479.506844384025;5480.890382192413;5490.835274941758;5493.423190564933;5495.0658388073325;5240.7641656126325;5289.656172348785;5373.946260537501;5428.70142142186;5481.5340696041285;5400.7569659364635;5458.754356054066;5483.862903427446;5500.50495455411;5504.422035686355;5366.382865970308;5388.892222155613;5389.1107967186545;5389.946100538945;5393.164059570773 19:31:51 INFO - PID 22693 | |1;ext.html;665.3645768291279;699.3600855217476;718.0342439418981;1009.530568285747;1025.8512515685222;25021.74978250217;25574.10490632826;25576.488470230583;25594.104206352782;25628.743712562868;30911;31207.219819504524;31429.84285078577;31439;31451.21371965702;7297.014902988095;7456.7762967111075;7461.365783908374;7463.701451941915;7471.738489152881;5609.80365687201;7211.134663840347;7459.813504662399;7462.552246865178;7464.552126872378;5741.339745929209;7258.383037441798;7436;7441.404687625004;7450.701971921144;7417.554946703188;7467.141278752959;7469.178390377054;7478.775636730907;7480.775576732707;5611.523020543259;7199.892001619927;7287.708491660327;7292.12494500658;7296.5622062675875;25992.22023339303;26388.340291492674;26400.339991500176;29744;30258.84870575655;2583.225032490245;2597.6233446150204;2601.518719036965;2610.686717593901;2620.6724159480063;22566;22577.661335079985;22786.77213227863;22867.31398058061;23000.53998920029;2628.6057091436437;2651.509470747918;2667.4931762964975;2684.5973104034356;2690.0853709738585;144849;144961;145026.27486862603;145633;145769;41829.37255941163;41917;41934.580654193676;41997;42006.36990445146;44075.33886991697;44259.11481770411;44333.556664432945;44361.556384435746;44392.55607443884;12603.621891343275;12984.610461686165;12985.220886746825;12995;13010.804837927439;10433.530491127918;10443.373397596168;10457.111145552713;10459.424731639681;10464.372137671764;10805.729856753644;10981.505832237568;12378.75242495145;12990.740185196242;13059.869401306056;5017.222330538772;5181.689098654093;5191.636585438983;5211.7915283389;5315.441878602691;713.8179764160105;745.2249660353281;745.2510227221716;750.7747675697269;760.4600733479292;16371.918140409221;16657.109662878935;16831.287239572695;17175.828241717674;17191;799.116975741797;806.8416984566262;811.8498077855616;818.9795255118551;847.4957400346907;8471.576421178916;8561.700340488178;8611.181937715906;8713.869291960626;8761.56192190388;207212;207288;207366;207905;208253;41811.7909410451;41831.16337673229;41878.162436751096;41967.370489442685;42015.7899210502;1177.9469923853446;1223.2599277437023;1234.4691782533775;1240.5720026590811;1248.4881198708485;15865.68268634644;16153.273102710642;16193.919030404773;16573.83426165771;16942.57643558921;31479.84260078685;31492.842535787175;31564.526532101576;31569;31601.20996975094;202877;203219;204217;204257;205985;27869.58195627108;28199.57700634533;28581.42837143287;28667.856660716563;29258.561121583618;33995.83002084974;34227.31545369029;34505.137371565914;34824.47763283603;34857.47713784346;26785.33036674099;26847.731522684524;27472;28018.159455216377;28465.146045618665;26681.7331826687;26736.732632674204;27165.86417067902;27176.592351115145;28074.85962570174;29872;30480.237994050327;30496.847515762278;30515.2371190722;30552.541711874783;26713.46573068489;26805.195844124708;27435;27656;27661.30846728848;17484.30062797474;17818.792617329007;18258.45224643263;22366.552668946206;23338.53322933566 19:31:51 INFO - PID 22693 | |2;jquery.html;383.14176245210734;408.61181877216643;411.218684499451;413.5843477305308;439.65706748735977;12037;13463.326833658315;17472.563185920357;17645.823541764577;17889.642207155848;15979.840201597981;17174.656506869855;18608.162632681528;19453.416397508063;19460;5467.863303417426;5637.774489020434;5645.266115405012;5647.463490968372;5654.575906806986;5258.6581872178185;5498.917516237259;5513;5529.253550770655;5533.280673512438;5480.04099282626;5486.725663716818;5489;5505;5515.145152501369;5445.673259604437;5448.318960129984;5481.150421684605;5598.104303311491;5642.266505354319;4919.21292593187;5056.6713163644245;5086.364204474441;5097.23541468779;5103.413107492649;21553;21560.460988475257;21649.242276520403;21698.240561580427;21981.23065692693;1525.4203402707012;1544.95365139046;1550.666606679558;1575.314738088935;1594.1869646480263;13946.23295718735;14145.080569763035;14151.504697335648;14159.22124283164;14705.70588588233;1677.0943690407166;1723.4140392266563;1732.3070771691298;1746.0920321432784;1760.6566719489704;74401;75381.24618753797;75753;75953.24046759517;75995.86006209966;10722.303050301705;10756.408397538211;11022.50398732059;11111.999680115152;11177.83233251502;15515.844841551665;15517.22413879324;15546.300416481285;15546.76679849803;15549.144797036046;7474.887876681854;7785.844283114306;7848.568328741974;8022.719204827919;8029.839403211903;7225.783226503213;7236.565806051653;7316.268373162641;7398.815029624302;7458.016793282731;6776.356246156607;6845.863082738417;6904.447644188453;6955.93044069563;7091.290870912868;1963.793801650806;2023.5649335392961;2040.1635329515125;2042.2137477071435;2063.329417939176;765.2424100140931;801.5911884938723;803.7347675267148;808.6320724070533;811.411726498284;15323.46367877119;15673.843261567466;15886.76169857453;15931.681366372608;16315.265813038443;809.1544336168718;817.7056259746487;817.7342363731692;824.3693574415457;829.5478963964533;8435.409521333571;8442.775797509326;8705.91294087051;8756.605952732143;8897.688580899638;403480.54752881936;422669;426745;426818;430298;83706;84761.57619211865;88357.55821220853;88706.78233044225;89163;1080.90812280957;1100.3287994323457;1109.384291718088;1114.8160553508742;1118.340179294204;13757.449702011807;13847.515336963157;13883.236421996888;13986.510472133426;14242.430302788187;39506;39748.801255994695;40155.39766903557;41065.178696425304;41143.588564113976;50702.23946640877;52222.73888630533;52432;52768;53127.468725313796;7335.77992660221;7424.109106907205;7537.849243015218;7539.9246007541415;7576.772696819105;10999.395033273247;11059.502322395672;11459.255148415326;11486.483108259981;11527.654170374903;9404.905950940676;9620.807583848424;9669.806603868024;9673.806523869624;9694.127528522467;8906.421082629608;9307.20888724439;9472.336936414385;9528.19010384125;9752.366096203725;9238.353315267866;9634.325597208128;9684;9707.466089365153;10285.640002599874;7323;7651.846963060819;7661.463697541119;7821.726239581587;7959.08470525897;8700.56497175126;9533.666321678707;9597.520123993912;9733.610655573697;9966.302358835102 19:31:51 INFO - PID 22693 | |3;mootools.html;1268.860425353211;1303.8044293355995;1325.0658285908435;1328.674474753685;1333.7199188170484;9411.152996230338;9803.950980245107;9806.901930980688;9808.656697015615;9824.36141650794;9589.616415343378;9758.219342452605;10071.69784906454;10127.544260508277;10137.898621013788;2242.8878556072173;2274.783895529922;2277.7722227777253;2281.167373908528;2281.8174546036275;1850.1581780290003;2124.6706760452153;2208.3485371815354;2217.9889100554474;2221.577900198957;1899.6865517189647;2159.686845407415;2254.3237028891267;2261.525079733258;2264.909403623853;2173.7608863025052;2190.89045547722;2197.560487902418;2200.702905107806;2205.94485137872;2051.8153366197116;2104.842136839743;2115.7461104667536;2120.162535798351;2121.1515393842433;9504.239660827117;9701;9706.61173553057;9711.125998660154;10021;5452.209429632681;5649.124385720179;5654.802081927113;5661.377248502661;5665.320161580596;3012.2770535071645;3235.175030367241;3241.8865339712997;3263.3636440894034;3270.378628060661;942.6182396129578;983.3608154699431;984.0798853072329;1004.6634377483551;1062.1874266186373;14503.057301275383;14699.412023519046;14710.33803478846;14721.926390368088;14737.557873263711;4739.928901066487;4848;4965.478624744422;4997.150484417658;5047.747612619354;10959.50682219302;10999.780004399867;11002.229843911009;11005.669829905115;11019.889801101886;5575;5591.049521581341;5594.216809646653;5596.104623260258;5596.832095037155;5009.749512524432;5021.6735912165595;5037.269595908646;5049.116404629175;5081.263216833612;3624.873129440457;3727.1986522897164;3804.619538046173;3828.119532507483;3848.3265428549894;1041.250299784154;1055.0030221440818;1078.0836289154156;1081.0270756319376;1083.1659622090947;646.6669665122465;676.8984652302194;683.1051322767191;685.7051467868864;689.6586189835963;5459.3994660587305;5553.722313884289;5629.155626656035;5919.496842768327;6005;804.4650307545417;813.6175997281268;823.4400607586779;831.1895901495993;847.4788005376649;3575.3564358415733;3615.5480564929385;3727.29181455528;3807.638274363931;3921.0589458530317;12463;12953.870461295455;13167.868321316664;13215.074944753775;13299.601011969657;12779.552715655094;13023.804642930363;13162.276074815785;13174.47302107924;13174.73650526984;9312.674056407994;9457.763555911157;9458.527073646152;9460.8580871287;9461.24310055194;5767.163761254678;5868.413158684098;6057.515398768176;6063.575549711654;6081.50313569708;10810.135189185004;10908.454577270946;10978.835317470084;11022.779544409228;11844.881551184722;11748.823767643664;12031.45858436355;12101.213421127599;12135.75728485443;12224.266544007389;8187.222213889671;8389.664413423394;8411.747647570583;8432.957835210786;8434.536100514531;9270.629174832931;9336.39313444624;9339.346245762732;9456.952715236379;9480.099390557885;8024.518528888052;8150.307223886036;8167.0199576051255;8193.221643943816;8228.711995080144;7727.647661659074;7847.332976696816;7899.289063984269;7921.920780792118;7973.601319934096;6856.897146542906;6972.825679358057;6979.616121113185;6982.720691172296;6989.091418115612;5194.091034069098;5223.3209682741;5307.124324486571;5320.44135365781;5501.752421141138;4881.267809828554;4904.166291730486;4961.677490963076;5057.216131499476;5135.614828887774 19:31:51 INFO - PID 22693 | |4;prototype.html;343.71986830732965;366.3533862732276;379.16772683958703;381.7060863135386;387.3009218360858;4753.405824271966;5354.95578362219;5383.730813459331;5397.514223719864;5418.59360547959;5169;5272.1300985337375;5282.762275697593;5310.0972834618115;5329.946700532993;4120.320147175712;4265.440735558655;4272.2950713132295;4276.6792490563175;4287.614114729674;4126.979365103185;4224.471941007374;4264.104538047014;4264.189803937257;4280.850170244042;4212.7682977436225;4225.450691410128;4229.154169166164;4237.894052648678;4240.936385954213;4091.8772436826944;4244.299690551055;4256.936145957813;4258.68059895509;4262.531121576624;3677.687396571295;3732.5504763045988;3766.303233901737;3817.770933743984;3831.482749828793;5171.146760784466;5181.4300426953005;5194.63637545372;5204.8959020819375;5208.244804503326;4810.759378219961;4867;4897.755112244409;4903.117438861003;4911.600193944744;5557.916631250535;5559.861003474905;5613.578981576398;5635.549156067505;5641.943580564182;4160.916781664349;4188;4191.161767646452;4192.853250136231;4194.3708443733685;5673.290838645169;5830.475257226827;5850.014729893707;5864.648121112747;5893.469587737124;4249.490061192677;4293.720908140961;4303.354496825438;4313.374560688682;4314.892127696833;4196.069618198604;4353.521112677603;4368.475782906072;4374.19077470669;4380.123975204971;4749.073930583503;4792.640551958617;4877.975610121997;4881.560659540587;4896.706197628154;5610.4670056344585;5614.905093506727;5628.915566266509;5630.5214056805635;5637.943620563742;1474.5134105745078;1503.1432083712398;1511.4709851551868;1517.6054225901346;1518.3091693279532;1038.5741845843168;1058.380847204394;1061.9734506637396;1068.3536460441476;1086.5653738504661;4826.12845357012;4836.830710925171;4843.176659967814;4863.270509423614;4875.219964805614;5757.568182386338;5784.946344047887;5790.536757059425;5792.536597072224;5817.185594016841;4750.358701575312;4760.578787728095;4857.295692124622;4857.4171099467585;4877.292792545132;3016.653084895221;3035.301880567482;3052.969470305313;3055.2890381386496;3063.2801291696433;5316.494932981361;5366.195070739421;5377.919331210035;5378.7041712705395;5388;5788.392218817048;5856.912146317809;5911.7635294587735;5934.37689042653;5946;5420.349558053059;5421.972890135524;5428.809991650273;5433.592480563973;5457.799284157479;5568.716826101279;5748.338941021836;5764.164196191613;5772.740226689725;5803.30360356743;5655.717214139194;5681.431856814451;5682.914756278742;5686.43135686428;5694.686792226302;5425.972870135624;5426.945730542644;5429.701366424884;5439.918401224064;5455.372632147195;4155.8961025974595;4254.914901701886;4274.252005898893;4309.116631090556;4322.9351559726;5473.534749546333;5662.433756624305;5671.943280567141;5706.172604972173;5808.39011903744;5458.61789674719;5519.724013799374;5560.499555040065;5563.332400111851;5571.526420254162;5354.946450535601;5575.498205161555;5602.439756024365;5604.8038318658655;5619;5556.361018482926;5577.6653400796085;5581.218629391808;5596.944030559643;5601.439856014366;5676.545876329967;5690.918725442153;5701;5705.286839145107;5723.942760572341;5309.681419114865;5481.588880833874;5511.421300763523;5519.957615682223;5553.0837411828215 19:31:51 INFO - PID 22693 | |5;yui.html;694.9652517374127;701.6877489517165;705.2806137739506;706.3713295167305;706.7279097547442;12866.806997895039;13242.933785331084;13253.138545994516;13253.668658283548;13265.27041012744;12559.560415385464;14246.786298205536;14726.779098313507;14813.111213327207;14838.480653177141;847.7414388611471;849.5285116760211;864.5201912938317;865.16079402979;865.8354912566592;849.8810166576684;862.9007664118612;863.2705363967438;863.8445079885618;864.1617630898019;903.1645727701882;906.1165363770305;908.5775114571722;908.6229214875818;908.995455022724;902.9774255643596;903.4488961733338;903.5617725403174;904.1320332480793;911.7766147293922;661.9304972977816;661.9338066193342;662.0565693886241;664.8204984654117;665.0157766505599;11998.10014248926;12442.066844986663;13901.443942242398;14020.43918243269;14044.438222471088;13450.394732236975;13690.452381904712;14084.084534505224;14139.010269281052;14229.001253656532;9873.555689993967;10049.145822605087;10074.244431667654;10485.475726213735;10554.630587929463;2738.4659991301705;2745.8764355603844;2750.917472475829;2811.859407029661;2819.238805522518;62203.377966220665;62411.687941560005;62534;62708;63400.95381877429;10438.321509102036;10496.26526143178;10511.894881051245;10557.208209384327;10809.35143891369;21347.78652213489;21425.46436339073;21464.034118464708;21543.138274468845;21669.566608668054;6634.800955971328;6697.665116744143;6814.250432452426;6858.554193977376;6946.687399067054;3232.69289417505;3318.386098571724;3362.4283871741864;3416.641252668484;3422.486627005919;3585.372559802024;3658.268346330691;3659.9634003660153;3692.372296709566;3701.5373078365205;631.504269148716;631.6399652198203;637.6715991264502;652.725855140842;655.7213184396612;516.9922451163236;531.7633653024444;534.9364948310862;536.1314670234168;537.1191246355979;8061.959690201512;8273.586320683942;8332.125126861592;8470.449420787752;8542.44474109181;533.4079172118945;552.7540244591198;553.6429003292934;554.3403350013471;555.5722093987607;3626.9274614507563;3653.872114476034;3663.3405986922075;3674.5039419678;3870.3226935286775;60642.393576064555;61660;63227;63335;65259.347406525325;51783.48216517862;53268.73365633147;53434;54093.45906540963;54869.45130548644;48056.759716201894;48364;48568;48572.51427485751;49592.504074960234;7378.704851806082;7481.438892083007;7529.343833066186;7567.578374919973;7649.732259370895;26263.868680656473;26281.342966425993;26623.86688066547;26627.467450651267;27268.181954541396;32400;32844;32857;33615.66384336125;33674.83162584171;9848.225323582497;9898.208143348658;10010.299279050396;10035.548400321857;10112.140468060003;10373.429461379697;12189.939050304693;12257.26456412618;12721;12741.936290318488;11398.316101033965;11509.769804603693;11665.300081995107;11719.179657423898;11913;12565.74868502643;12838.614841554769;12980.221186728826;13171.473141074634;13376.866231337563;10425.374477531372;10879;10899.237053406185;11217.775644487228;11235.775284494428;8458.323334133378;8701.17338852808;8861.822763544822;8964.955175224082;9234.861477077715;9886;10268.743281418025;10587.629432969808;10637.840432393676;10718.19613529004 19:31:51 INFO - PID 22693 | __end_tp_report 19:31:51 INFO - PID 22693 | __start_cc_report 19:31:51 INFO - PID 22693 | _x_x_mozilla_cycle_collect,1595 19:31:51 INFO - PID 22693 | __end_cc_report 19:31:51 INFO - PID 22693 | __startTimestamp1490495511602__endTimestamp 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | ------- Summary: start ------- 19:31:51 INFO - PID 22693 | Number of tests: 6 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#0] dojo.html Cycles:165 Average:5150.68 Median:5292.21 stddev:585.90 (11.1%) stddev-sans-first:555.17 19:31:51 INFO - PID 22693 | Values: 2696.6 2724.6 2756.2 2763.2 2769.0 5065.5 5101.6 5253.0 5263.2 5267.6 5210.9 5216.4 5246.1 5282.9 5283.2 4682.5 4722.4 4757.3 4862.5 4905.8 4815.4 4819.5 4819.7 4854.3 4922.0 4661.9 4685.0 4701.5 4775.7 4791.3 4745.5 4748.8 4751.6 4813.4 4836.7 4687.4 4719.8 4746.7 4764.7 4794.9 5026.8 5069.1 5070.2 5179.0 5190.5 5585.3 5599.2 5643.8 5644.8 5651.3 5680.5 5685.3 5696.4 5701.0 5704.7 5131.3 5231.3 5233.9 5246.9 5292.8 5648.4 5673.2 5702.9 5704.0 5706.3 5443.6 5533.2 5539.8 5573.3 5573.4 5617.6 5631.9 5632.0 5632.9 5636.1 5572.1 5590.7 5598.5 5599.9 5603.2 5398.4 5418.0 5429.0 5457.8 5553.5 4686.5 4688.4 4708.5 4732.9 4737.9 4006.9 4011.5 4014.5 4046.4 4050.9 4631.4 4682.6 4769.1 4786.1 4829.1 5566.4 5670.5 5702.9 5707.2 5712.0 4690.6 4729.4 4733.1 4734.7 4776.8 4985.0 4993.5 5000.9 5004.1 5039.6 5075.7 5138.7 5140.9 5248.9 5306.0 5691.8 5708.1 5717.4 5718.5 5720.5 5239.9 5278.4 5292.2 5340.2 5344.6 5506.3 5560.9 5561.4 5563.5 5614.1 5430.0 5512.3 5530.9 5626.0 5652.5 5351.3 5475.5 5482.4 5521.7 5531.3 5479.5 5480.9 5490.8 5493.4 5495.1 5240.8 5289.7 5373.9 5428.7 5481.5 5400.8 5458.8 5483.9 5500.5 5504.4 5366.4 5388.9 5389.1 5389.9 5393.2 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#1] ext.html Cycles:180 Average:31841.84 Median:28332.36 stddev:48917.34 (172.7%) stddev-sans-first:48998.56 19:31:51 INFO - PID 22693 | Values: 665.4 699.4 718.0 1009.5 1025.9 25021.7 25574.1 25576.5 25594.1 25628.7 30911.0 31207.2 31429.8 31439.0 31451.2 7297.0 7456.8 7461.4 7463.7 7471.7 5609.8 7211.1 7459.8 7462.6 7464.6 5741.3 7258.4 7436.0 7441.4 7450.7 7417.6 7467.1 7469.2 7478.8 7480.8 5611.5 7199.9 7287.7 7292.1 7296.6 25992.2 26388.3 26400.3 29744.0 30258.8 2583.2 2597.6 2601.5 2610.7 2620.7 22566.0 22577.7 22786.8 22867.3 23000.5 2628.6 2651.5 2667.5 2684.6 2690.1 144849.0 144961.0 145026.3 145633.0 145769.0 41829.4 41917.0 41934.6 41997.0 42006.4 44075.3 44259.1 44333.6 44361.6 44392.6 12603.6 12984.6 12985.2 12995.0 13010.8 10433.5 10443.4 10457.1 10459.4 10464.4 10805.7 10981.5 12378.8 12990.7 13059.9 5017.2 5181.7 5191.6 5211.8 5315.4 713.8 745.2 745.3 750.8 760.5 16371.9 16657.1 16831.3 17175.8 17191.0 799.1 806.8 811.8 819.0 847.5 8471.6 8561.7 8611.2 8713.9 8761.6 207212.0 207288.0 207366.0 207905.0 208253.0 41811.8 41831.2 41878.2 41967.4 42015.8 1177.9 1223.3 1234.5 1240.6 1248.5 15865.7 16153.3 16193.9 16573.8 16942.6 31479.8 31492.8 31564.5 31569.0 31601.2 202877.0 203219.0 204217.0 204257.0 205985.0 27869.6 28199.6 28581.4 28667.9 29258.6 33995.8 34227.3 34505.1 34824.5 34857.5 26785.3 26847.7 27472.0 28018.2 28465.1 26681.7 26736.7 27165.9 27176.6 28074.9 29872.0 30480.2 30496.8 30515.2 30552.5 26713.5 26805.2 27435.0 27656.0 27661.3 17484.3 17818.8 18258.5 22366.6 23338.5 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#2] jquery.html Cycles:180 Average:25945.38 Median:52947.73 stddev:69842.82 (131.9%) stddev-sans-first:70012.37 19:31:51 INFO - PID 22693 | Values: 383.1 408.6 411.2 413.6 439.7 12037.0 13463.3 17472.6 17645.8 17889.6 15979.8 17174.7 18608.2 19453.4 19460.0 5467.9 5637.8 5645.3 5647.5 5654.6 5258.7 5498.9 5513.0 5529.3 5533.3 5480.0 5486.7 5489.0 5505.0 5515.1 5445.7 5448.3 5481.2 5598.1 5642.3 4919.2 5056.7 5086.4 5097.2 5103.4 21553.0 21560.5 21649.2 21698.2 21981.2 1525.4 1545.0 1550.7 1575.3 1594.2 13946.2 14145.1 14151.5 14159.2 14705.7 1677.1 1723.4 1732.3 1746.1 1760.7 74401.0 75381.2 75753.0 75953.2 75995.9 10722.3 10756.4 11022.5 11112.0 11177.8 15515.8 15517.2 15546.3 15546.8 15549.1 7474.9 7785.8 7848.6 8022.7 8029.8 7225.8 7236.6 7316.3 7398.8 7458.0 6776.4 6845.9 6904.4 6955.9 7091.3 1963.8 2023.6 2040.2 2042.2 2063.3 765.2 801.6 803.7 808.6 811.4 15323.5 15673.8 15886.8 15931.7 16315.3 809.2 817.7 817.7 824.4 829.5 8435.4 8442.8 8705.9 8756.6 8897.7 403480.5 422669.0 426745.0 426818.0 430298.0 83706.0 84761.6 88357.6 88706.8 89163.0 1080.9 1100.3 1109.4 1114.8 1118.3 13757.4 13847.5 13883.2 13986.5 14242.4 39506.0 39748.8 40155.4 41065.2 41143.6 50702.2 52222.7 52432.0 52768.0 53127.5 7335.8 7424.1 7537.8 7539.9 7576.8 10999.4 11059.5 11459.3 11486.5 11527.7 9404.9 9620.8 9669.8 9673.8 9694.1 8906.4 9307.2 9472.3 9528.2 9752.4 9238.4 9634.3 9684.0 9707.5 10285.6 7323.0 7651.8 7661.5 7821.7 7959.1 8700.6 9533.7 9597.5 9733.6 9966.3 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#3] mootools.html Cycles:180 Average:6223.77 Median:4963.58 stddev:3968.41 (80.0%) stddev-sans-first:3962.08 19:31:51 INFO - PID 22693 | Values: 1268.9 1303.8 1325.1 1328.7 1333.7 9411.2 9804.0 9806.9 9808.7 9824.4 9589.6 9758.2 10071.7 10127.5 10137.9 2242.9 2274.8 2277.8 2281.2 2281.8 1850.2 2124.7 2208.3 2218.0 2221.6 1899.7 2159.7 2254.3 2261.5 2264.9 2173.8 2190.9 2197.6 2200.7 2205.9 2051.8 2104.8 2115.7 2120.2 2121.2 9504.2 9701.0 9706.6 9711.1 10021.0 5452.2 5649.1 5654.8 5661.4 5665.3 3012.3 3235.2 3241.9 3263.4 3270.4 942.6 983.4 984.1 1004.7 1062.2 14503.1 14699.4 14710.3 14721.9 14737.6 4739.9 4848.0 4965.5 4997.2 5047.7 10959.5 10999.8 11002.2 11005.7 11019.9 5575.0 5591.0 5594.2 5596.1 5596.8 5009.7 5021.7 5037.3 5049.1 5081.3 3624.9 3727.2 3804.6 3828.1 3848.3 1041.3 1055.0 1078.1 1081.0 1083.2 646.7 676.9 683.1 685.7 689.7 5459.4 5553.7 5629.2 5919.5 6005.0 804.5 813.6 823.4 831.2 847.5 3575.4 3615.5 3727.3 3807.6 3921.1 12463.0 12953.9 13167.9 13215.1 13299.6 12779.6 13023.8 13162.3 13174.5 13174.7 9312.7 9457.8 9458.5 9460.9 9461.2 5767.2 5868.4 6057.5 6063.6 6081.5 10810.1 10908.5 10978.8 11022.8 11844.9 11748.8 12031.5 12101.2 12135.8 12224.3 8187.2 8389.7 8411.7 8433.0 8434.5 9270.6 9336.4 9339.3 9457.0 9480.1 8024.5 8150.3 8167.0 8193.2 8228.7 7727.6 7847.3 7899.3 7921.9 7973.6 6856.9 6972.8 6979.6 6982.7 6989.1 5194.1 5223.3 5307.1 5320.4 5501.8 4881.3 4904.2 4961.7 5057.2 5135.6 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#4] prototype.html Cycles:180 Average:4687.44 Median:5206.57 stddev:1319.52 (25.3%) stddev-sans-first:1282.32 19:31:51 INFO - PID 22693 | Values: 343.7 366.4 379.2 381.7 387.3 4753.4 5355.0 5383.7 5397.5 5418.6 5169.0 5272.1 5282.8 5310.1 5329.9 4120.3 4265.4 4272.3 4276.7 4287.6 4127.0 4224.5 4264.1 4264.2 4280.9 4212.8 4225.5 4229.2 4237.9 4240.9 4091.9 4244.3 4256.9 4258.7 4262.5 3677.7 3732.6 3766.3 3817.8 3831.5 5171.1 5181.4 5194.6 5204.9 5208.2 4810.8 4867.0 4897.8 4903.1 4911.6 5557.9 5559.9 5613.6 5635.5 5641.9 4160.9 4188.0 4191.2 4192.9 4194.4 5673.3 5830.5 5850.0 5864.6 5893.5 4249.5 4293.7 4303.4 4313.4 4314.9 4196.1 4353.5 4368.5 4374.2 4380.1 4749.1 4792.6 4878.0 4881.6 4896.7 5610.5 5614.9 5628.9 5630.5 5637.9 1474.5 1503.1 1511.5 1517.6 1518.3 1038.6 1058.4 1062.0 1068.4 1086.6 4826.1 4836.8 4843.2 4863.3 4875.2 5757.6 5784.9 5790.5 5792.5 5817.2 4750.4 4760.6 4857.3 4857.4 4877.3 3016.7 3035.3 3053.0 3055.3 3063.3 5316.5 5366.2 5377.9 5378.7 5388.0 5788.4 5856.9 5911.8 5934.4 5946.0 5420.3 5422.0 5428.8 5433.6 5457.8 5568.7 5748.3 5764.2 5772.7 5803.3 5655.7 5681.4 5682.9 5686.4 5694.7 5426.0 5426.9 5429.7 5439.9 5455.4 4155.9 4254.9 4274.3 4309.1 4322.9 5473.5 5662.4 5671.9 5706.2 5808.4 5458.6 5519.7 5560.5 5563.3 5571.5 5354.9 5575.5 5602.4 5604.8 5619.0 5556.4 5577.7 5581.2 5596.9 5601.4 5676.5 5690.9 5701.0 5705.3 5723.9 5309.7 5481.6 5511.4 5520.0 5553.1 19:31:51 INFO - PID 22693 | 19:31:51 INFO - PID 22693 | [#5] yui.html Cycles:180 Average:13993.67 Median:25963.54 stddev:17012.16 (65.5%) stddev-sans-first:17030.58 19:31:51 INFO - PID 22693 | Values: 695.0 701.7 705.3 706.4 706.7 12866.8 13242.9 13253.1 13253.7 13265.3 12559.6 14246.8 14726.8 14813.1 14838.5 847.7 849.5 864.5 865.2 865.8 849.9 862.9 863.3 863.8 864.2 903.2 906.1 908.6 908.6 909.0 903.0 903.4 903.6 904.1 911.8 661.9 661.9 662.1 664.8 665.0 11998.1 12442.1 13901.4 14020.4 14044.4 13450.4 13690.5 14084.1 14139.0 14229.0 9873.6 10049.1 10074.2 10485.5 10554.6 2738.5 2745.9 2750.9 2811.9 2819.2 62203.4 62411.7 62534.0 62708.0 63401.0 10438.3 10496.3 10511.9 10557.2 10809.4 21347.8 21425.5 21464.0 21543.1 21669.6 6634.8 6697.7 6814.3 6858.6 6946.7 3232.7 3318.4 3362.4 3416.6 3422.5 3585.4 3658.3 3660.0 3692.4 3701.5 631.5 631.6 637.7 652.7 655.7 517.0 531.8 534.9 536.1 537.1 8062.0 8273.6 8332.1 8470.4 8542.4 533.4 552.8 553.6 554.3 555.6 3626.9 3653.9 3663.3 3674.5 3870.3 60642.4 61660.0 63227.0 63335.0 65259.3 51783.5 53268.7 53434.0 54093.5 54869.5 48056.8 48364.0 48568.0 48572.5 49592.5 7378.7 7481.4 7529.3 7567.6 7649.7 26263.9 26281.3 26623.9 26627.5 27268.2 32400.0 32844.0 32857.0 33615.7 33674.8 9848.2 9898.2 10010.3 10035.5 10112.1 10373.4 12189.9 12257.3 12721.0 12741.9 11398.3 11509.8 11665.3 11719.2 11913.0 12565.7 12838.6 12980.2 13171.5 13376.9 10425.4 10879.0 10899.2 11217.8 11235.8 8458.3 8701.2 8861.8 8965.0 9234.9 9886.0 10268.7 10587.6 10637.8 10718.2 19:31:51 INFO - PID 22693 | -------- Summary: end -------- 19:31:51 INFO - PID 22693 | 19:31:52 INFO - TEST-INFO | 22693: exit 0 19:31:52 INFO - TEST-OK | dromaeo_css | took 1123658ms 19:31:52 INFO - TEST-START | kraken 19:31:52 INFO - operating with platform_type : linux_ 19:31:52 INFO - Initialising browser for kraken test... 19:31:52 INFO - TEST-INFO | started process 23016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGCgLTI/profile http://localhost:49678/getInfo.html) 19:31:56 INFO - PID 23016 | __metrics Screen width/height:1600/1200 19:31:56 INFO - PID 23016 | colorDepth:24 19:31:56 INFO - PID 23016 | Browser inner width/height: 1024/697 19:31:56 INFO - PID 23016 | __metrics 19:31:57 ERROR - PID 23016 | 1490495517390 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 19:31:57 INFO - PID 23016 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:31:57 INFO - PID 23016 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:31:58 INFO - TEST-INFO | 23016: exit 0 19:31:58 INFO - Browser initialized. 19:31:58 INFO - Running cycle 1/1 for kraken test... 19:31:58 INFO - TEST-INFO | started process 23108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGCgLTI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:32:10 INFO - PID 23108 | RSS: Main: 149766144 19:32:10 INFO - PID 23108 | 19:32:13 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49678/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:14 INFO - PID 23108 | RSS: Main: 204918784 19:32:14 INFO - PID 23108 | 19:32:17 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49678/tests/kraken/driver.html?testName=audio-dft) 19:32:17 INFO - PID 23108 | RSS: Main: 183472128 19:32:17 INFO - PID 23108 | 19:32:20 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49678/tests/kraken/driver.html?testName=audio-fft) 19:32:21 INFO - PID 23108 | RSS: Main: 266547200 19:32:21 INFO - PID 23108 | 19:32:23 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49678/tests/kraken/driver.html?testName=audio-oscillator) 19:32:24 INFO - PID 23108 | RSS: Main: 176328704 19:32:24 INFO - PID 23108 | 19:32:26 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:26 INFO - PID 23108 | RSS: Main: 180486144 19:32:26 INFO - PID 23108 | 19:32:30 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49678/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:30 INFO - PID 23108 | RSS: Main: 219774976 19:32:30 INFO - PID 23108 | 19:32:34 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49678/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:34 INFO - PID 23108 | RSS: Main: 214839296 19:32:34 INFO - PID 23108 | 19:32:37 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49678/tests/kraken/driver.html?testName=json-parse-financial) 19:32:38 INFO - PID 23108 | RSS: Main: 217210880 19:32:38 INFO - PID 23108 | 19:32:40 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:40 INFO - PID 23108 | RSS: Main: 180338688 19:32:40 INFO - PID 23108 | 19:32:42 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:43 INFO - PID 23108 | RSS: Main: 186998784 19:32:43 INFO - PID 23108 | 19:32:45 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:46 INFO - PID 23108 | RSS: Main: 196673536 19:32:46 INFO - PID 23108 | 19:32:48 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:49 INFO - PID 23108 | RSS: Main: 205393920 19:32:49 INFO - PID 23108 | 19:32:52 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:53 INFO - PID 23108 | RSS: Main: 202293248 19:32:53 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | Cycle 1(1): loaded http://localhost:49678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49678/tests/kraken/driver.html?testName=ai-astar) 19:32:55 INFO - PID 23108 | RSS: Main: 271286272 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | __start_tp_report 19:32:55 INFO - PID 23108 | _x_x_mozilla_page_load 19:32:55 INFO - PID 23108 | _x_x_mozilla_page_load_details 19:32:55 INFO - PID 23108 | |i|pagename|runs| 19:32:55 INFO - PID 23108 | |0;ai-astar;108;111;111;110;111;113;109;111;110;112 19:32:55 INFO - PID 23108 | |1;audio-beat-detection;155;124;123;173;123;127;123;122;149;123 19:32:55 INFO - PID 23108 | |2;audio-dft;162;162;162;163;163;161;162;165;160;161 19:32:55 INFO - PID 23108 | |3;audio-fft;77;75;75;118;74;75;74;75;91;75 19:32:55 INFO - PID 23108 | |4;audio-oscillator;84;84;117;84;85;86;100;84;84;109 19:32:55 INFO - PID 23108 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;115;113;113 19:32:55 INFO - PID 23108 | |6;imaging-darkroom;149;149;149;149;149;149;148;149;150;149 19:32:55 INFO - PID 23108 | |7;imaging-desaturate;93;94;94;94;93;94;95;94;94;93 19:32:55 INFO - PID 23108 | |8;json-parse-financial;65;64;65;64;64;66;66;65;66;67 19:32:55 INFO - PID 23108 | |9;json-stringify-tinderbox;54;55;55;54;55;55;55;55;55;55 19:32:55 INFO - PID 23108 | |10;stanford-crypto-aes;82;84;81;82;82;83;81;82;84;81 19:32:55 INFO - PID 23108 | |11;stanford-crypto-ccm;135;132;130;131;130;131;129;132;182;129 19:32:55 INFO - PID 23108 | |12;stanford-crypto-pbkdf2;187;190;196;192;194;190;193;184;184;192 19:32:55 INFO - PID 23108 | |13;stanford-crypto-sha256-iterative;72;72;70;69;71;69;69;74;70;69 19:32:55 INFO - PID 23108 | __end_tp_report 19:32:55 INFO - PID 23108 | __start_cc_report 19:32:55 INFO - PID 23108 | _x_x_mozilla_cycle_collect,2046 19:32:55 INFO - PID 23108 | __end_cc_report 19:32:55 INFO - PID 23108 | __startTimestamp1490495575440__endTimestamp 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | ------- Summary: start ------- 19:32:55 INFO - PID 23108 | Number of tests: 14 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.43 (1.3%) stddev-sans-first:1.17 19:32:55 INFO - PID 23108 | Values: 108.0 111.0 111.0 110.0 111.0 113.0 109.0 111.0 110.0 112.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:125.50 stddev:18.15 (14.5%) stddev-sans-first:17.62 19:32:55 INFO - PID 23108 | Values: 155.0 124.0 123.0 173.0 123.0 127.0 123.0 122.0 149.0 123.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 19:32:55 INFO - PID 23108 | Values: 162.0 162.0 162.0 163.0 163.0 161.0 162.0 165.0 160.0 161.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:14.00 (18.7%) stddev-sans-first:14.77 19:32:55 INFO - PID 23108 | Values: 77.0 75.0 75.0 118.0 74.0 75.0 74.0 75.0 91.0 75.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:12.39 (14.8%) stddev-sans-first:12.83 19:32:55 INFO - PID 23108 | Values: 84.0 84.0 117.0 84.0 85.0 86.0 100.0 84.0 84.0 109.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 19:32:55 INFO - PID 23108 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 115.0 113.0 113.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 19:32:55 INFO - PID 23108 | Values: 149.0 149.0 149.0 149.0 149.0 149.0 148.0 149.0 150.0 149.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:32:55 INFO - PID 23108 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 93.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 19:32:55 INFO - PID 23108 | Values: 65.0 64.0 65.0 64.0 64.0 66.0 66.0 65.0 66.0 67.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 19:32:55 INFO - PID 23108 | Values: 54.0 55.0 55.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.14 (1.4%) stddev-sans-first:1.20 19:32:55 INFO - PID 23108 | Values: 82.0 84.0 81.0 82.0 82.0 83.0 81.0 82.0 84.0 81.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:131.50 stddev:16.22 (12.3%) stddev-sans-first:17.20 19:32:55 INFO - PID 23108 | Values: 135.0 132.0 130.0 131.0 130.0 131.0 129.0 132.0 182.0 129.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.20 Median:192.00 stddev:4.08 (2.1%) stddev-sans-first:4.16 19:32:55 INFO - PID 23108 | Values: 187.0 190.0 196.0 192.0 194.0 190.0 193.0 184.0 184.0 192.0 19:32:55 INFO - PID 23108 | 19:32:55 INFO - PID 23108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:1.72 (2.4%) stddev-sans-first:1.73 19:32:55 INFO - PID 23108 | Values: 72.0 72.0 70.0 69.0 71.0 69.0 69.0 74.0 70.0 69.0 19:32:55 INFO - PID 23108 | -------- Summary: end -------- 19:32:55 INFO - PID 23108 | 19:32:56 INFO - TEST-INFO | 23108: exit 0 19:32:56 INFO - TEST-OK | kraken | took 64126ms 19:32:56 INFO - SUITE-END | took 1187s 19:32:57 INFO - Completed test suite (00:19:48) 19:32:57 INFO - javascript benchmark 19:32:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6499.711606315783, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2696.5550684137115, 2724.550449175886, 2756.2144788735213, 2763.157237042701, 2768.972310276897, 5065.544101030907, 5101.591872650189, 5253.028189784888, 5263.184206447997, 5267.55225805806, 5210.895782084356, 5216.374035115791, 5246.108161612526, 5282.867928301795, 5283.233931079991, 4682.461516925563, 4722.362481065046, 4757.310190022454, 4862.465128835825, 4905.75471226439, 4815.422149342101, 4819.493953134923, 4819.686720363183, 4854.296127061574, 4921.950780492203, 4661.86014419568, 4684.95315046852, 4701.529847015271, 4775.737334446604, 4791.329213910055, 4745.477997420316, 4748.833790817304, 4751.619870410359, 4813.446453657839, 4836.709797412132, 4687.414073240845, 4719.834805781816, 4746.715197088151, 4764.69029513084, 4794.880127996793, 5026.773795179226, 5069.138246498104, 5070.239464080418, 5178.974105129488, 5190.4550022247495, 5585.329760428734, 5599.216109744639, 5643.774249030034, 5644.8306550803545, 5651.2935883014625, 5680.517156041741, 5685.260916080924, 5696.3733989261145, 5701.0, 5704.71476426177, 5131.25596788471, 5231.346081739783, 5233.895322093536, 5246.947530524722, 5292.841214763564, 5648.350439699405, 5673.234113394639, 5702.885942281131, 5704.030314846486, 5706.3152421709665, 5443.646162999472, 5533.170024496278, 5539.750711217925, 5573.331200255914, 5573.442655734394, 5617.634853734494, 5631.943680563224, 5631.971840140855, 5632.85917852057, 5636.098224284095, 5572.136318870582, 5590.720463976785, 5598.468145526169, 5599.8880022400135, 5603.2435621191435, 5398.406175320712, 5418.0, 5429.022775900376, 5457.781688732406, 5553.50018498329, 4686.531346865286, 4688.367070445514, 4708.458527269408, 4732.858014259577, 4737.928931066037, 4006.899827504336, 4011.478507793968, 4014.4781178447197, 4046.4132700758814, 4050.9392359114636, 4631.374764406762, 4682.578567928835, 4769.070031343924, 4786.138495070851, 4829.13075646387, 5566.387697353288, 5670.489655930986, 5702.914456283159, 5707.172459993278, 5711.971440142773, 4690.624750019991, 4729.361536192639, 4733.053389322149, 4734.692245004064, 4776.832810851603, 4985.0, 4993.50064993505, 5000.874978125648, 5004.149294619923, 5039.647224694236, 5075.695458272516, 5138.743062846917, 5140.922886156636, 5248.947510524846, 5306.044911915892, 5691.77232910679, 5708.143778433268, 5717.37108918027, 5718.485336319751, 5720.456556627114, 5239.947600523946, 5278.419373868948, 5292.206169074516, 5340.172273297645, 5344.5991550634635, 5506.311711036121, 5560.944390556043, 5561.416051314553, 5563.471470210324, 5614.1017437211485, 5429.972850135882, 5512.3385193777, 5530.861728456821, 5625.971870140623, 5652.519535839499, 5351.3043304370185, 5475.5072043516275, 5482.39693633708, 5521.696306703009, 5531.280933478622, 5479.506844384025, 5480.890382192413, 5490.835274941758, 5493.423190564933, 5495.0658388073325, 5240.7641656126325, 5289.656172348785, 5373.946260537501, 5428.70142142186, 5481.5340696041285, 5400.7569659364635, 5458.754356054066, 5483.862903427446, 5500.50495455411, 5504.422035686355, 5366.382865970308, 5388.892222155613, 5389.1107967186545, 5389.946100538945, 5393.164059570773], "value": 5109.219374951237, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3645768291279, 699.3600855217476, 718.0342439418981, 1009.530568285747, 1025.8512515685222, 25021.74978250217, 25574.10490632826, 25576.488470230583, 25594.104206352782, 25628.743712562868, 30911.0, 31207.219819504524, 31429.84285078577, 31439.0, 31451.21371965702, 7297.014902988095, 7456.7762967111075, 7461.365783908374, 7463.701451941915, 7471.738489152881, 5609.80365687201, 7211.134663840347, 7459.813504662399, 7462.552246865178, 7464.552126872378, 5741.339745929209, 7258.383037441798, 7436.0, 7441.404687625004, 7450.701971921144, 7417.554946703188, 7467.141278752959, 7469.178390377054, 7478.775636730907, 7480.775576732707, 5611.523020543259, 7199.892001619927, 7287.708491660327, 7292.12494500658, 7296.5622062675875, 25992.22023339303, 26388.340291492674, 26400.339991500176, 29744.0, 30258.84870575655, 2583.225032490245, 2597.6233446150204, 2601.518719036965, 2610.686717593901, 2620.6724159480063, 22566.0, 22577.661335079985, 22786.77213227863, 22867.31398058061, 23000.53998920029, 2628.6057091436437, 2651.509470747918, 2667.4931762964975, 2684.5973104034356, 2690.0853709738585, 144849.0, 144961.0, 145026.27486862603, 145633.0, 145769.0, 41829.37255941163, 41917.0, 41934.580654193676, 41997.0, 42006.36990445146, 44075.33886991697, 44259.11481770411, 44333.556664432945, 44361.556384435746, 44392.55607443884, 12603.621891343275, 12984.610461686165, 12985.220886746825, 12995.0, 13010.804837927439, 10433.530491127918, 10443.373397596168, 10457.111145552713, 10459.424731639681, 10464.372137671764, 10805.729856753644, 10981.505832237568, 12378.75242495145, 12990.740185196242, 13059.869401306056, 5017.222330538772, 5181.689098654093, 5191.636585438983, 5211.7915283389, 5315.441878602691, 713.8179764160105, 745.2249660353281, 745.2510227221716, 750.7747675697269, 760.4600733479292, 16371.918140409221, 16657.109662878935, 16831.287239572695, 17175.828241717674, 17191.0, 799.116975741797, 806.8416984566262, 811.8498077855616, 818.9795255118551, 847.4957400346907, 8471.576421178916, 8561.700340488178, 8611.181937715906, 8713.869291960626, 8761.56192190388, 207212.0, 207288.0, 207366.0, 207905.0, 208253.0, 41811.7909410451, 41831.16337673229, 41878.162436751096, 41967.370489442685, 42015.7899210502, 1177.9469923853446, 1223.2599277437023, 1234.4691782533775, 1240.5720026590811, 1248.4881198708485, 15865.68268634644, 16153.273102710642, 16193.919030404773, 16573.83426165771, 16942.57643558921, 31479.84260078685, 31492.842535787175, 31564.526532101576, 31569.0, 31601.20996975094, 202877.0, 203219.0, 204217.0, 204257.0, 205985.0, 27869.58195627108, 28199.57700634533, 28581.42837143287, 28667.856660716563, 29258.561121583618, 33995.83002084974, 34227.31545369029, 34505.137371565914, 34824.47763283603, 34857.47713784346, 26785.33036674099, 26847.731522684524, 27472.0, 28018.159455216377, 28465.146045618665, 26681.7331826687, 26736.732632674204, 27165.86417067902, 27176.592351115145, 28074.85962570174, 29872.0, 30480.237994050327, 30496.847515762278, 30515.2371190722, 30552.541711874783, 26713.46573068489, 26805.195844124708, 27435.0, 27656.0, 27661.30846728848, 17484.30062797474, 17818.792617329007, 18258.45224643263, 22366.552668946206, 23338.53322933566], "value": 13925.14912697156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.14176245210734, 408.61181877216643, 411.218684499451, 413.5843477305308, 439.65706748735977, 12037.0, 13463.326833658315, 17472.563185920357, 17645.823541764577, 17889.642207155848, 15979.840201597981, 17174.656506869855, 18608.162632681528, 19453.416397508063, 19460.0, 5467.863303417426, 5637.774489020434, 5645.266115405012, 5647.463490968372, 5654.575906806986, 5258.6581872178185, 5498.917516237259, 5513.0, 5529.253550770655, 5533.280673512438, 5480.04099282626, 5486.725663716818, 5489.0, 5505.0, 5515.145152501369, 5445.673259604437, 5448.318960129984, 5481.150421684605, 5598.104303311491, 5642.266505354319, 4919.21292593187, 5056.6713163644245, 5086.364204474441, 5097.23541468779, 5103.413107492649, 21553.0, 21560.460988475257, 21649.242276520403, 21698.240561580427, 21981.23065692693, 1525.4203402707012, 1544.95365139046, 1550.666606679558, 1575.314738088935, 1594.1869646480263, 13946.23295718735, 14145.080569763035, 14151.504697335648, 14159.22124283164, 14705.70588588233, 1677.0943690407166, 1723.4140392266563, 1732.3070771691298, 1746.0920321432784, 1760.6566719489704, 74401.0, 75381.24618753797, 75753.0, 75953.24046759517, 75995.86006209966, 10722.303050301705, 10756.408397538211, 11022.50398732059, 11111.999680115152, 11177.83233251502, 15515.844841551665, 15517.22413879324, 15546.300416481285, 15546.76679849803, 15549.144797036046, 7474.887876681854, 7785.844283114306, 7848.568328741974, 8022.719204827919, 8029.839403211903, 7225.783226503213, 7236.565806051653, 7316.268373162641, 7398.815029624302, 7458.016793282731, 6776.356246156607, 6845.863082738417, 6904.447644188453, 6955.93044069563, 7091.290870912868, 1963.793801650806, 2023.5649335392961, 2040.1635329515125, 2042.2137477071435, 2063.329417939176, 765.2424100140931, 801.5911884938723, 803.7347675267148, 808.6320724070533, 811.411726498284, 15323.46367877119, 15673.843261567466, 15886.76169857453, 15931.681366372608, 16315.265813038443, 809.1544336168718, 817.7056259746487, 817.7342363731692, 824.3693574415457, 829.5478963964533, 8435.409521333571, 8442.775797509326, 8705.91294087051, 8756.605952732143, 8897.688580899638, 403480.54752881936, 422669.0, 426745.0, 426818.0, 430298.0, 83706.0, 84761.57619211865, 88357.55821220853, 88706.78233044225, 89163.0, 1080.90812280957, 1100.3287994323457, 1109.384291718088, 1114.8160553508742, 1118.340179294204, 13757.449702011807, 13847.515336963157, 13883.236421996888, 13986.510472133426, 14242.430302788187, 39506.0, 39748.801255994695, 40155.39766903557, 41065.178696425304, 41143.588564113976, 50702.23946640877, 52222.73888630533, 52432.0, 52768.0, 53127.468725313796, 7335.77992660221, 7424.109106907205, 7537.849243015218, 7539.9246007541415, 7576.772696819105, 10999.395033273247, 11059.502322395672, 11459.255148415326, 11486.483108259981, 11527.654170374903, 9404.905950940676, 9620.807583848424, 9669.806603868024, 9673.806523869624, 9694.127528522467, 8906.421082629608, 9307.20888724439, 9472.336936414385, 9528.19010384125, 9752.366096203725, 9238.353315267866, 9634.325597208128, 9684.0, 9707.466089365153, 10285.640002599874, 7323.0, 7651.846963060819, 7661.463697541119, 7821.726239581587, 7959.08470525897, 8700.56497175126, 9533.666321678707, 9597.520123993912, 9733.610655573697, 9966.302358835102], "value": 8489.052085332232, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.860425353211, 1303.8044293355995, 1325.0658285908435, 1328.674474753685, 1333.7199188170484, 9411.152996230338, 9803.950980245107, 9806.901930980688, 9808.656697015615, 9824.36141650794, 9589.616415343378, 9758.219342452605, 10071.69784906454, 10127.544260508277, 10137.898621013788, 2242.8878556072173, 2274.783895529922, 2277.7722227777253, 2281.167373908528, 2281.8174546036275, 1850.1581780290003, 2124.6706760452153, 2208.3485371815354, 2217.9889100554474, 2221.577900198957, 1899.6865517189647, 2159.686845407415, 2254.3237028891267, 2261.525079733258, 2264.909403623853, 2173.7608863025052, 2190.89045547722, 2197.560487902418, 2200.702905107806, 2205.94485137872, 2051.8153366197116, 2104.842136839743, 2115.7461104667536, 2120.162535798351, 2121.1515393842433, 9504.239660827117, 9701.0, 9706.61173553057, 9711.125998660154, 10021.0, 5452.209429632681, 5649.124385720179, 5654.802081927113, 5661.377248502661, 5665.320161580596, 3012.2770535071645, 3235.175030367241, 3241.8865339712997, 3263.3636440894034, 3270.378628060661, 942.6182396129578, 983.3608154699431, 984.0798853072329, 1004.6634377483551, 1062.1874266186373, 14503.057301275383, 14699.412023519046, 14710.33803478846, 14721.926390368088, 14737.557873263711, 4739.928901066487, 4848.0, 4965.478624744422, 4997.150484417658, 5047.747612619354, 10959.50682219302, 10999.780004399867, 11002.229843911009, 11005.669829905115, 11019.889801101886, 5575.0, 5591.049521581341, 5594.216809646653, 5596.104623260258, 5596.832095037155, 5009.749512524432, 5021.6735912165595, 5037.269595908646, 5049.116404629175, 5081.263216833612, 3624.873129440457, 3727.1986522897164, 3804.619538046173, 3828.119532507483, 3848.3265428549894, 1041.250299784154, 1055.0030221440818, 1078.0836289154156, 1081.0270756319376, 1083.1659622090947, 646.6669665122465, 676.8984652302194, 683.1051322767191, 685.7051467868864, 689.6586189835963, 5459.3994660587305, 5553.722313884289, 5629.155626656035, 5919.496842768327, 6005.0, 804.4650307545417, 813.6175997281268, 823.4400607586779, 831.1895901495993, 847.4788005376649, 3575.3564358415733, 3615.5480564929385, 3727.29181455528, 3807.638274363931, 3921.0589458530317, 12463.0, 12953.870461295455, 13167.868321316664, 13215.074944753775, 13299.601011969657, 12779.552715655094, 13023.804642930363, 13162.276074815785, 13174.47302107924, 13174.73650526984, 9312.674056407994, 9457.763555911157, 9458.527073646152, 9460.8580871287, 9461.24310055194, 5767.163761254678, 5868.413158684098, 6057.515398768176, 6063.575549711654, 6081.50313569708, 10810.135189185004, 10908.454577270946, 10978.835317470084, 11022.779544409228, 11844.881551184722, 11748.823767643664, 12031.45858436355, 12101.213421127599, 12135.75728485443, 12224.266544007389, 8187.222213889671, 8389.664413423394, 8411.747647570583, 8432.957835210786, 8434.536100514531, 9270.629174832931, 9336.39313444624, 9339.346245762732, 9456.952715236379, 9480.099390557885, 8024.518528888052, 8150.307223886036, 8167.0199576051255, 8193.221643943816, 8228.711995080144, 7727.647661659074, 7847.332976696816, 7899.289063984269, 7921.920780792118, 7973.601319934096, 6856.897146542906, 6972.825679358057, 6979.616121113185, 6982.720691172296, 6989.091418115612, 5194.091034069098, 5223.3209682741, 5307.124324486571, 5320.44135365781, 5501.752421141138, 4881.267809828554, 4904.166291730486, 4961.677490963076, 5057.216131499476, 5135.614828887774], "value": 4681.584195167725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.71986830732965, 366.3533862732276, 379.16772683958703, 381.7060863135386, 387.3009218360858, 4753.405824271966, 5354.95578362219, 5383.730813459331, 5397.514223719864, 5418.59360547959, 5169.0, 5272.1300985337375, 5282.762275697593, 5310.0972834618115, 5329.946700532993, 4120.320147175712, 4265.440735558655, 4272.2950713132295, 4276.6792490563175, 4287.614114729674, 4126.979365103185, 4224.471941007374, 4264.104538047014, 4264.189803937257, 4280.850170244042, 4212.7682977436225, 4225.450691410128, 4229.154169166164, 4237.894052648678, 4240.936385954213, 4091.8772436826944, 4244.299690551055, 4256.936145957813, 4258.68059895509, 4262.531121576624, 3677.687396571295, 3732.5504763045988, 3766.303233901737, 3817.770933743984, 3831.482749828793, 5171.146760784466, 5181.4300426953005, 5194.63637545372, 5204.8959020819375, 5208.244804503326, 4810.759378219961, 4867.0, 4897.755112244409, 4903.117438861003, 4911.600193944744, 5557.916631250535, 5559.861003474905, 5613.578981576398, 5635.549156067505, 5641.943580564182, 4160.916781664349, 4188.0, 4191.161767646452, 4192.853250136231, 4194.3708443733685, 5673.290838645169, 5830.475257226827, 5850.014729893707, 5864.648121112747, 5893.469587737124, 4249.490061192677, 4293.720908140961, 4303.354496825438, 4313.374560688682, 4314.892127696833, 4196.069618198604, 4353.521112677603, 4368.475782906072, 4374.19077470669, 4380.123975204971, 4749.073930583503, 4792.640551958617, 4877.975610121997, 4881.560659540587, 4896.706197628154, 5610.4670056344585, 5614.905093506727, 5628.915566266509, 5630.5214056805635, 5637.943620563742, 1474.5134105745078, 1503.1432083712398, 1511.4709851551868, 1517.6054225901346, 1518.3091693279532, 1038.5741845843168, 1058.380847204394, 1061.9734506637396, 1068.3536460441476, 1086.5653738504661, 4826.12845357012, 4836.830710925171, 4843.176659967814, 4863.270509423614, 4875.219964805614, 5757.568182386338, 5784.946344047887, 5790.536757059425, 5792.536597072224, 5817.185594016841, 4750.358701575312, 4760.578787728095, 4857.295692124622, 4857.4171099467585, 4877.292792545132, 3016.653084895221, 3035.301880567482, 3052.969470305313, 3055.2890381386496, 3063.2801291696433, 5316.494932981361, 5366.195070739421, 5377.919331210035, 5378.7041712705395, 5388.0, 5788.392218817048, 5856.912146317809, 5911.7635294587735, 5934.37689042653, 5946.0, 5420.349558053059, 5421.972890135524, 5428.809991650273, 5433.592480563973, 5457.799284157479, 5568.716826101279, 5748.338941021836, 5764.164196191613, 5772.740226689725, 5803.30360356743, 5655.717214139194, 5681.431856814451, 5682.914756278742, 5686.43135686428, 5694.686792226302, 5425.972870135624, 5426.945730542644, 5429.701366424884, 5439.918401224064, 5455.372632147195, 4155.8961025974595, 4254.914901701886, 4274.252005898893, 4309.116631090556, 4322.9351559726, 5473.534749546333, 5662.433756624305, 5671.943280567141, 5706.172604972173, 5808.39011903744, 5458.61789674719, 5519.724013799374, 5560.499555040065, 5563.332400111851, 5571.526420254162, 5354.946450535601, 5575.498205161555, 5602.439756024365, 5604.8038318658655, 5619.0, 5556.361018482926, 5577.6653400796085, 5581.218629391808, 5596.944030559643, 5601.439856014366, 5676.545876329967, 5690.918725442153, 5701.0, 5705.286839145107, 5723.942760572341, 5309.681419114865, 5481.588880833874, 5511.421300763523, 5519.957615682223, 5553.0837411828215], "value": 4285.694302591874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.9652517374127, 701.6877489517165, 705.2806137739506, 706.3713295167305, 706.7279097547442, 12866.806997895039, 13242.933785331084, 13253.138545994516, 13253.668658283548, 13265.27041012744, 12559.560415385464, 14246.786298205536, 14726.779098313507, 14813.111213327207, 14838.480653177141, 847.7414388611471, 849.5285116760211, 864.5201912938317, 865.16079402979, 865.8354912566592, 849.8810166576684, 862.9007664118612, 863.2705363967438, 863.8445079885618, 864.1617630898019, 903.1645727701882, 906.1165363770305, 908.5775114571722, 908.6229214875818, 908.995455022724, 902.9774255643596, 903.4488961733338, 903.5617725403174, 904.1320332480793, 911.7766147293922, 661.9304972977816, 661.9338066193342, 662.0565693886241, 664.8204984654117, 665.0157766505599, 11998.10014248926, 12442.066844986663, 13901.443942242398, 14020.43918243269, 14044.438222471088, 13450.394732236975, 13690.452381904712, 14084.084534505224, 14139.010269281052, 14229.001253656532, 9873.555689993967, 10049.145822605087, 10074.244431667654, 10485.475726213735, 10554.630587929463, 2738.4659991301705, 2745.8764355603844, 2750.917472475829, 2811.859407029661, 2819.238805522518, 62203.377966220665, 62411.687941560005, 62534.0, 62708.0, 63400.95381877429, 10438.321509102036, 10496.26526143178, 10511.894881051245, 10557.208209384327, 10809.35143891369, 21347.78652213489, 21425.46436339073, 21464.034118464708, 21543.138274468845, 21669.566608668054, 6634.800955971328, 6697.665116744143, 6814.250432452426, 6858.554193977376, 6946.687399067054, 3232.69289417505, 3318.386098571724, 3362.4283871741864, 3416.641252668484, 3422.486627005919, 3585.372559802024, 3658.268346330691, 3659.9634003660153, 3692.372296709566, 3701.5373078365205, 631.504269148716, 631.6399652198203, 637.6715991264502, 652.725855140842, 655.7213184396612, 516.9922451163236, 531.7633653024444, 534.9364948310862, 536.1314670234168, 537.1191246355979, 8061.959690201512, 8273.586320683942, 8332.125126861592, 8470.449420787752, 8542.44474109181, 533.4079172118945, 552.7540244591198, 553.6429003292934, 554.3403350013471, 555.5722093987607, 3626.9274614507563, 3653.872114476034, 3663.3405986922075, 3674.5039419678, 3870.3226935286775, 60642.393576064555, 61660.0, 63227.0, 63335.0, 65259.347406525325, 51783.48216517862, 53268.73365633147, 53434.0, 54093.45906540963, 54869.45130548644, 48056.759716201894, 48364.0, 48568.0, 48572.51427485751, 49592.504074960234, 7378.704851806082, 7481.438892083007, 7529.343833066186, 7567.578374919973, 7649.732259370895, 26263.868680656473, 26281.342966425993, 26623.86688066547, 26627.467450651267, 27268.181954541396, 32400.0, 32844.0, 32857.0, 33615.66384336125, 33674.83162584171, 9848.225323582497, 9898.208143348658, 10010.299279050396, 10035.548400321857, 10112.140468060003, 10373.429461379697, 12189.939050304693, 12257.26456412618, 12721.0, 12741.936290318488, 11398.316101033965, 11509.769804603693, 11665.300081995107, 11719.179657423898, 11913.0, 12565.74868502643, 12838.614841554769, 12980.221186728826, 13171.473141074634, 13376.866231337563, 10425.374477531372, 10879.0, 10899.237053406185, 11217.775644487228, 11235.775284494428, 8458.323334133378, 8701.17338852808, 8861.822763544822, 8964.955175224082, 9234.861477077715, 9886.0, 10268.743281418025, 10587.629432969808, 10637.840432393676, 10718.19613529004], "value": 6221.663968094627, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 110.0, 111.0, 113.0, 109.0, 111.0, 110.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 123.0, 173.0, 123.0, 127.0, 123.0, 122.0, 149.0, 123.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 165.0, 160.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 118.0, 74.0, 75.0, 74.0, 75.0, 91.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 85.0, 86.0, 100.0, 84.0, 84.0, 109.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 150.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 82.0, 82.0, 83.0, 81.0, 82.0, 84.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 130.0, 131.0, 130.0, 131.0, 129.0, 132.0, 182.0, 129.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 190.0, 196.0, 192.0, 194.0, 190.0, 193.0, 184.0, 184.0, 192.0], "value": 190.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 69.0, 71.0, 69.0, 69.0, 74.0, 70.0, 69.0], "value": 70.5, "unit": "score"}]}]} 19:32:57 INFO - Return code: 0 19:32:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:57 ERROR - # TBPL SUCCESS # 19:32:57 INFO - Running post-action listener: _resource_record_post_action 19:32:57 INFO - [mozharness: 2017-03-26 02:32:57.257624Z] Finished run-tests step (success) 19:32:57 INFO - Running post-run listener: _resource_record_post_run 19:32:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 366030848; Read time: 0; Write time: 185104 19:32:57 INFO - TinderboxPrint: CPU usage
12.9% 19:32:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:32:57 INFO - TinderboxPrint: I/O write bytes / time
366,030,848 / 185,104 19:32:57 INFO - TinderboxPrint: CPU idle
8,365.8 (87.0%) 19:32:57 INFO - TinderboxPrint: CPU user
1,199.7 (12.5%) 19:32:57 INFO - TinderboxPrint: Swap in / out
0 / 0 19:32:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105877504; Read time: 0; Write time: 58884 19:32:57 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 260153344; Read time: 0; Write time: 126220 19:32:57 INFO - Running post-run listener: _upload_blobber_files 19:32:57 INFO - Blob upload gear active. 19:32:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:57 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 19:32:57 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'] 19:32:57 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 19:32:58 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:02 INFO - (blobuploader) - INFO - Done attempting. 19:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:03 INFO - (blobuploader) - INFO - Done attempting. 19:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:04 INFO - (blobuploader) - INFO - Done attempting. 19:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:05 INFO - (blobuploader) - INFO - Done attempting. 19:33:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:05 INFO - Return code: 0 19:33:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2774effa1c491ec1908a74e6bfb391f69e0e13e6b791f8aa14e433714e7c58596e6f29d887632fc75c9c9dc93cfd175d5ace159dc3738efd64cf189cbdb6291b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79f69eaf7cc9368c69e2c91d82612e222a2a547da96e8100cc913ba2196cb7a3e9fd777f8cffabd8d810fae17a745209fecc05b7658e081977dcad098df684b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3ddce39b18023715a4576414dfd6477ef5d39f9a35aba59f4c81b7ed8720d0244db18c19957dde99199c7a893aac007ae69ea5f9df0d7a3f02ca9d19f363f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7cd170f87cb6618ff6f14661f468dc24d26c0f1babae9fb695bb962706bd2ffc4c26de545f9b70c55bbe9b9f0de21091785737a6aa7aefd41320dc7f563a43a"} 19:33:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:05 INFO - Contents: 19:33:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2774effa1c491ec1908a74e6bfb391f69e0e13e6b791f8aa14e433714e7c58596e6f29d887632fc75c9c9dc93cfd175d5ace159dc3738efd64cf189cbdb6291b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79f69eaf7cc9368c69e2c91d82612e222a2a547da96e8100cc913ba2196cb7a3e9fd777f8cffabd8d810fae17a745209fecc05b7658e081977dcad098df684b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3ddce39b18023715a4576414dfd6477ef5d39f9a35aba59f4c81b7ed8720d0244db18c19957dde99199c7a893aac007ae69ea5f9df0d7a3f02ca9d19f363f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7cd170f87cb6618ff6f14661f468dc24d26c0f1babae9fb695bb962706bd2ffc4c26de545f9b70c55bbe9b9f0de21091785737a6aa7aefd41320dc7f563a43a"} 19:33:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:05 INFO - Copying logs to upload dir... 19:33:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.514404 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-25 19:33:04.397148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:04.400829) ========= 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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2774effa1c491ec1908a74e6bfb391f69e0e13e6b791f8aa14e433714e7c58596e6f29d887632fc75c9c9dc93cfd175d5ace159dc3738efd64cf189cbdb6291b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79f69eaf7cc9368c69e2c91d82612e222a2a547da96e8100cc913ba2196cb7a3e9fd777f8cffabd8d810fae17a745209fecc05b7658e081977dcad098df684b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3ddce39b18023715a4576414dfd6477ef5d39f9a35aba59f4c81b7ed8720d0244db18c19957dde99199c7a893aac007ae69ea5f9df0d7a3f02ca9d19f363f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7cd170f87cb6618ff6f14661f468dc24d26c0f1babae9fb695bb962706bd2ffc4c26de545f9b70c55bbe9b9f0de21091785737a6aa7aefd41320dc7f563a43a"} build_url:https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2774effa1c491ec1908a74e6bfb391f69e0e13e6b791f8aa14e433714e7c58596e6f29d887632fc75c9c9dc93cfd175d5ace159dc3738efd64cf189cbdb6291b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79f69eaf7cc9368c69e2c91d82612e222a2a547da96e8100cc913ba2196cb7a3e9fd777f8cffabd8d810fae17a745209fecc05b7658e081977dcad098df684b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e3ddce39b18023715a4576414dfd6477ef5d39f9a35aba59f4c81b7ed8720d0244db18c19957dde99199c7a893aac007ae69ea5f9df0d7a3f02ca9d19f363f1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7cd170f87cb6618ff6f14661f468dc24d26c0f1babae9fb695bb962706bd2ffc4c26de545f9b70c55bbe9b9f0de21091785737a6aa7aefd41320dc7f563a43a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:04.430583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:04.431419) ========= 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-1490476293.496195-1357241158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:04.515803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 19:33:04.516555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 19:33:04.517218) ========= ========= Total master_lag: 0.19 =========