builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1489938751.37 results: success (0) revision: 51844ae447dbc52cec81abb4c1a6e676b905a743 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.371301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.371759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.372050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.386682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.386997) ========= 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=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-19 08:52:34-- 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% 18.2M=0.001s 2017-03-19 08:52:34 (18.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.534110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.534461) ========= 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=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.584090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:31.584450) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51844ae447dbc52cec81abb4c1a6e676b905a743 --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 51844ae447dbc52cec81abb4c1a6e676b905a743 --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=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-19 08:52:34,794 truncating revision to first 12 chars 2017-03-19 08:52:34,795 Setting DEBUG logging. 2017-03-19 08:52:34,795 attempt 1/10 2017-03-19 08:52:34,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51844ae447db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-19 08:52:35,228 unpacking tar archive at: mozilla-central-51844ae447db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738604 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:32.335995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:32.336336) ========= script_repo_revision: 51844ae447dbc52cec81abb4c1a6e676b905a743 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:32.336708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:32.336979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-19 08:52:32.345465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-19 08:52:32.345750) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:52:35 INFO - MultiFileLogger online at 20170319 08:52:35 in /builds/slave/test 08:52:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:52:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:35 INFO - {'append_to_log': False, 08:52:35 INFO - 'base_work_dir': '/builds/slave/test', 08:52:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:52:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:35 INFO - 'branch': 'Firefox-Non-PGO', 08:52:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:35 INFO - 'config_files': ('talos/linux_config.py',), 08:52:35 INFO - 'default_actions': ('clobber', 08:52:35 INFO - 'read-buildbot-config', 08:52:35 INFO - 'download-and-extract', 08:52:35 INFO - 'populate-webroot', 08:52:35 INFO - 'create-virtualenv', 08:52:35 INFO - 'install', 08:52:35 INFO - 'run-tests'), 08:52:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:35 INFO - 'download_minidump_stackwalk': True, 08:52:35 INFO - 'download_symbols': 'ondemand', 08:52:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:35 INFO - 'gecko_profile': False, 08:52:35 INFO - 'gecko_profile_interval': 0, 08:52:35 INFO - 'installer_path': 'installer.exe', 08:52:35 INFO - 'log_level': 'info', 08:52:35 INFO - 'log_name': 'talos', 08:52:35 INFO - 'log_to_console': True, 08:52:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:52:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:52:35 INFO - 'opt_config_files': (), 08:52:35 INFO - 'pip_index': False, 08:52:35 INFO - 'suite': 'dromaeojs-e10s', 08:52:35 INFO - 'system_bits': '32', 08:52:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:35 INFO - 'title': 'talos-linux64-ix-080', 08:52:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:35 INFO - 'use_talos_json': True, 08:52:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:35 INFO - 'work_dir': 'build'} 08:52:35 INFO - [mozharness: 2017-03-19 15:52:35.654489Z] Running clobber step. 08:52:35 INFO - Running pre-action listener: _resource_record_pre_action 08:52:35 INFO - Running main action method: clobber 08:52:35 INFO - rmtree: /builds/slave/test/build 08:52:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:36 INFO - Running post-action listener: _resource_record_post_action 08:52:36 INFO - [mozharness: 2017-03-19 15:52:36.604934Z] Finished clobber step (success) 08:52:36 INFO - [mozharness: 2017-03-19 15:52:36.605034Z] Running read-buildbot-config step. 08:52:36 INFO - Running pre-action listener: _resource_record_pre_action 08:52:36 INFO - Running main action method: read_buildbot_config 08:52:36 INFO - Using buildbot properties: 08:52:36 INFO - { 08:52:36 INFO - "project": "", 08:52:36 INFO - "product": "firefox", 08:52:36 INFO - "who": "archaeopteryx@coole-files.de", 08:52:36 INFO - "installer_path": "public/build/target.tar.bz2", 08:52:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:52:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:52:36 INFO - "stage_platform": "linux64", 08:52:36 INFO - "basedir": "/builds/slave/test", 08:52:36 INFO - "buildnumber": 474, 08:52:36 INFO - "platform": "ubuntu64_hw", 08:52:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:52:36 INFO - "slavebuilddir": "test", 08:52:36 INFO - "taskId": "Xu97-x64RfWwFoocD9lnVw", 08:52:36 INFO - "branch": "mozilla-central", 08:52:36 INFO - "script_repo_revision": "production", 08:52:36 INFO - "revision": "51844ae447dbc52cec81abb4c1a6e676b905a743", 08:52:36 INFO - "slavename": "talos-linux64-ix-080", 08:52:36 INFO - "repo_path": "mozilla-central" 08:52:36 INFO - } 08:52:36 INFO - Finding installer, test and symbols from parent task. 08:52:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xu97-x64RfWwFoocD9lnVw'}, attempt #1 08:52:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xu97-x64RfWwFoocD9lnVw'}, attempt #1 08:52:37 INFO - Task dependencies: RZ-lBF4NR0GtKKVznm2DDQ 08:52:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ'}, attempt #1 08:52:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 08:52:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/test_packages.json 08:52:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.crashreporter-symbols.zip 08:52:37 INFO - Running post-action listener: _resource_record_post_action 08:52:37 INFO - [mozharness: 2017-03-19 15:52:37.976384Z] Finished read-buildbot-config step (success) 08:52:37 INFO - [mozharness: 2017-03-19 15:52:37.976602Z] Running download-and-extract step. 08:52:37 INFO - Running pre-action listener: _resource_record_pre_action 08:52:37 INFO - Running main action method: download_and_extract 08:52:37 INFO - mkdir: /builds/slave/test/build/tests 08:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:37 INFO - trying https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.test_packages.json 08:52:37 INFO - Downloading https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:52:38 INFO - Downloaded 986 bytes. 08:52:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:52:38 INFO - Using the following test package requirements: 08:52:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:52:38 INFO - u'common': [u'target.common.tests.zip'], 08:52:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:52:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:52:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:52:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:52:38 INFO - u'mozbase': [u'target.common.tests.zip'], 08:52:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:52:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:52:38 INFO - u'web-platform': [u'target.common.tests.zip', 08:52:38 INFO - u'target.web-platform.tests.zip'], 08:52:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:52:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:52:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip 08:52:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:38 INFO - Fetch https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip into memory 08:52:39 INFO - Expected file size: 58186535 08:52:39 INFO - Obtained file size: 58186535 08:52:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip 08:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.common.tests.zip into memory 08:52:50 INFO - Expected file size: 58186535 08:52:50 INFO - Obtained file size: 58186535 08:53:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.talos.tests.zip 08:53:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:53:01 INFO - Fetch https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.talos.tests.zip into memory 08:53:02 INFO - Expected file size: 14404171 08:53:02 INFO - Obtained file size: 14404171 08:53: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')]} 08:53:03 INFO - trying https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 08:53:03 INFO - Downloading https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:53:05 INFO - Downloaded 61750034 bytes. 08:53:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 08:53:05 INFO - mkdir: /builds/slave/test/properties 08:53:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:05 INFO - Contents: 08:53:05 INFO - build_url:https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 08:53:05 INFO - Running post-action listener: _resource_record_post_action 08:53:05 INFO - Running post-action listener: set_extra_try_arguments 08:53:05 INFO - [mozharness: 2017-03-19 15:53:05.945742Z] Finished download-and-extract step (success) 08:53:05 INFO - [mozharness: 2017-03-19 15:53:05.945893Z] Running populate-webroot step. 08:53:05 INFO - Running pre-action listener: _resource_record_pre_action 08:53:05 INFO - Running main action method: populate_webroot 08:53:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:05 INFO - '--tppagecycles', 08:53:05 INFO - '7'], 08:53:05 INFO - 'tests': ['tsvgm']}}, 08:53:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['damp', 'tps']}, 08:53:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'tests': ['damp', 'tps']}, 08:53:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['dromaeo_dom']}, 08:53:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['basic_compositor_video']}, 08:53:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['a11yr', 08:53:05 INFO - 'ts_paint', 08:53:05 INFO - 'tpaint', 08:53:05 INFO - 'sessionrestore', 08:53:05 INFO - 'sessionrestore_no_auto_restore', 08:53:05 INFO - 'tabpaint']}, 08:53:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['tsvgx', 08:53:05 INFO - 'tsvgr_opacity', 08:53:05 INFO - 'tart', 08:53:05 INFO - 'tscrollx', 08:53:05 INFO - 'cart', 08:53:05 INFO - 'tsvg_static']}, 08:53:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:05 INFO - 'tsvgr_opacity', 08:53:05 INFO - 'tart', 08:53:05 INFO - 'tscrollx', 08:53:05 INFO - 'cart', 08:53:05 INFO - 'tsvg_static']}, 08:53:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'talos_options': ['--disable-e10s'], 08:53:05 INFO - 'tests': ['tp5o']}, 08:53:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'talos_options': ['--disable-e10s', 08:53:05 INFO - '--xperf_path', 08:53:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:05 INFO - 'tests': ['tp5n']}, 08:53:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:05 INFO - 'talos_options': ['--xperf_path', 08:53:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:05 INFO - 'tests': ['tp5n']}}, 08:53:05 INFO - 'talos.zip': {'path': '', 08:53:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:05 INFO - Running post-action listener: _resource_record_post_action 08:53:05 INFO - [mozharness: 2017-03-19 15:53:05.965456Z] Finished populate-webroot step (success) 08:53:05 INFO - [mozharness: 2017-03-19 15:53:05.965547Z] Running create-virtualenv step. 08:53:05 INFO - Running pre-action listener: _resource_record_pre_action 08:53:05 INFO - Running main action method: create_virtualenv 08:53:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:53:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:06 INFO - Using real prefix '/usr' 08:53:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:08 INFO - Installing pip.................done. 08:53:08 INFO - Return code: 0 08:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:08 INFO - Reading from file tmpfile_stdout 08:53:08 INFO - Output received: 08:53:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:53:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:08 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:08 INFO - Using env: {'DISPLAY': ':0', 08:53:08 INFO - 'HOME': '/home/cltbld', 08:53:08 INFO - 'LANG': 'en_US.UTF-8', 08:53:08 INFO - 'LANGUAGE': 'en_US:en', 08:53:08 INFO - 'LOGNAME': 'cltbld', 08:53:08 INFO - 'MAIL': '/var/mail/cltbld', 08:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:08 INFO - 'MOZ_NO_REMOTE': '1', 08:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:08 INFO - 'NO_EM_RESTART': '1', 08:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:08 INFO - 'PWD': '/builds/slave/test', 08:53:08 INFO - 'SHELL': '/bin/bash', 08:53:08 INFO - 'SHLVL': '1', 08:53:08 INFO - 'TERM': 'linux', 08:53:08 INFO - 'TMOUT': '86400', 08:53:08 INFO - 'USER': 'cltbld', 08:53:08 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:08 INFO - '_': '/tools/buildbot/bin/python'} 08:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:53:08 INFO - Cleaning up... 08:53:08 INFO - Return code: 0 08:53:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:08 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:08 INFO - Using env: {'DISPLAY': ':0', 08:53:08 INFO - 'HOME': '/home/cltbld', 08:53:08 INFO - 'LANG': 'en_US.UTF-8', 08:53:08 INFO - 'LANGUAGE': 'en_US:en', 08:53:08 INFO - 'LOGNAME': 'cltbld', 08:53:08 INFO - 'MAIL': '/var/mail/cltbld', 08:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:08 INFO - 'MOZ_NO_REMOTE': '1', 08:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:08 INFO - 'NO_EM_RESTART': '1', 08:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:08 INFO - 'PWD': '/builds/slave/test', 08:53:08 INFO - 'SHELL': '/bin/bash', 08:53:08 INFO - 'SHLVL': '1', 08:53:08 INFO - 'TERM': 'linux', 08:53:08 INFO - 'TMOUT': '86400', 08:53:08 INFO - 'USER': 'cltbld', 08:53:08 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:08 INFO - '_': '/tools/buildbot/bin/python'} 08:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:09 INFO - Downloading/unpacking psutil>=3.1.1 08:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:11 INFO - Installing collected packages: psutil 08:53:11 INFO - Running setup.py install for psutil 08:53:11 INFO - building 'psutil._psutil_linux' extension 08:53:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:53:11 INFO - building 'psutil._psutil_posix' extension 08:53:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:11 INFO - Successfully installed psutil 08:53:11 INFO - Cleaning up... 08:53:11 INFO - Return code: 0 08:53:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:11 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:53:11 INFO - Using env: {'DISPLAY': ':0', 08:53:11 INFO - 'HOME': '/home/cltbld', 08:53:11 INFO - 'LANG': 'en_US.UTF-8', 08:53:11 INFO - 'LANGUAGE': 'en_US:en', 08:53:11 INFO - 'LOGNAME': 'cltbld', 08:53:11 INFO - 'MAIL': '/var/mail/cltbld', 08:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:11 INFO - 'MOZ_NO_REMOTE': '1', 08:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:11 INFO - 'NO_EM_RESTART': '1', 08:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:11 INFO - 'PWD': '/builds/slave/test', 08:53:11 INFO - 'SHELL': '/bin/bash', 08:53:11 INFO - 'SHLVL': '1', 08:53:11 INFO - 'TERM': 'linux', 08:53:11 INFO - 'TMOUT': '86400', 08:53:11 INFO - 'USER': 'cltbld', 08:53:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:11 INFO - '_': '/tools/buildbot/bin/python'} 08:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:14 INFO - Installing collected packages: mozsystemmonitor 08:53:14 INFO - Running setup.py install for mozsystemmonitor 08:53:14 INFO - Successfully installed mozsystemmonitor 08:53:14 INFO - Cleaning up... 08:53:14 INFO - Return code: 0 08:53:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:14 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:53:14 INFO - Using env: {'DISPLAY': ':0', 08:53:14 INFO - 'HOME': '/home/cltbld', 08:53:14 INFO - 'LANG': 'en_US.UTF-8', 08:53:14 INFO - 'LANGUAGE': 'en_US:en', 08:53:14 INFO - 'LOGNAME': 'cltbld', 08:53:14 INFO - 'MAIL': '/var/mail/cltbld', 08:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:14 INFO - 'MOZ_NO_REMOTE': '1', 08:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:14 INFO - 'NO_EM_RESTART': '1', 08:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:14 INFO - 'PWD': '/builds/slave/test', 08:53:14 INFO - 'SHELL': '/bin/bash', 08:53:14 INFO - 'SHLVL': '1', 08:53:14 INFO - 'TERM': 'linux', 08:53:14 INFO - 'TMOUT': '86400', 08:53:14 INFO - 'USER': 'cltbld', 08:53:14 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:14 INFO - '_': '/tools/buildbot/bin/python'} 08:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:16 INFO - warning: no files found matching '*.txt' 08:53:16 INFO - no previously-included directories found matching 'build' 08:53:16 INFO - no previously-included directories found matching 'dist' 08:53:16 INFO - no previously-included directories found matching '.git*' 08:53:16 INFO - Installing collected packages: jsonschema, functools32 08:53:16 INFO - Running setup.py install for functools32 08:53:16 INFO - warning: no files found matching '*.txt' 08:53:16 INFO - no previously-included directories found matching 'build' 08:53:16 INFO - no previously-included directories found matching 'dist' 08:53:16 INFO - no previously-included directories found matching '.git*' 08:53:16 INFO - Successfully installed jsonschema functools32 08:53:16 INFO - Cleaning up... 08:53:17 INFO - Return code: 0 08:53:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:17 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:53:17 INFO - Using env: {'DISPLAY': ':0', 08:53:17 INFO - 'HOME': '/home/cltbld', 08:53:17 INFO - 'LANG': 'en_US.UTF-8', 08:53:17 INFO - 'LANGUAGE': 'en_US:en', 08:53:17 INFO - 'LOGNAME': 'cltbld', 08:53:17 INFO - 'MAIL': '/var/mail/cltbld', 08:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:17 INFO - 'MOZ_NO_REMOTE': '1', 08:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:17 INFO - 'NO_EM_RESTART': '1', 08:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:17 INFO - 'PWD': '/builds/slave/test', 08:53:17 INFO - 'SHELL': '/bin/bash', 08:53:17 INFO - 'SHLVL': '1', 08:53:17 INFO - 'TERM': 'linux', 08:53:17 INFO - 'TMOUT': '86400', 08:53:17 INFO - 'USER': 'cltbld', 08:53:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:17 INFO - '_': '/tools/buildbot/bin/python'} 08:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:17 INFO - Cleaning up... 08:53:17 INFO - Return code: 0 08:53:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:17 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:17 INFO - Using env: {'DISPLAY': ':0', 08:53:17 INFO - 'HOME': '/home/cltbld', 08:53:17 INFO - 'LANG': 'en_US.UTF-8', 08:53:17 INFO - 'LANGUAGE': 'en_US:en', 08:53:17 INFO - 'LOGNAME': 'cltbld', 08:53:17 INFO - 'MAIL': '/var/mail/cltbld', 08:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:17 INFO - 'MOZ_NO_REMOTE': '1', 08:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:17 INFO - 'NO_EM_RESTART': '1', 08:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:17 INFO - 'PWD': '/builds/slave/test', 08:53:17 INFO - 'SHELL': '/bin/bash', 08:53:17 INFO - 'SHLVL': '1', 08:53:17 INFO - 'TERM': 'linux', 08:53:17 INFO - 'TMOUT': '86400', 08:53:17 INFO - 'USER': 'cltbld', 08:53:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:17 INFO - '_': '/tools/buildbot/bin/python'} 08:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:20 INFO - Downloading docopt-0.6.1.tar.gz 08:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:20 INFO - Running setup.py install for blobuploader 08:53:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:20 INFO - Running setup.py install for requests 08:53:20 INFO - Running setup.py install for docopt 08:53:20 INFO - Successfully installed blobuploader requests docopt 08:53:20 INFO - Cleaning up... 08:53:20 INFO - Return code: 0 08:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:20 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:20 INFO - Using env: {'DISPLAY': ':0', 08:53:20 INFO - 'HOME': '/home/cltbld', 08:53:20 INFO - 'LANG': 'en_US.UTF-8', 08:53:20 INFO - 'LANGUAGE': 'en_US:en', 08:53:20 INFO - 'LOGNAME': 'cltbld', 08:53:20 INFO - 'MAIL': '/var/mail/cltbld', 08:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:20 INFO - 'MOZ_NO_REMOTE': '1', 08:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:20 INFO - 'NO_EM_RESTART': '1', 08:53:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:20 INFO - 'PWD': '/builds/slave/test', 08:53:20 INFO - 'SHELL': '/bin/bash', 08:53:20 INFO - 'SHLVL': '1', 08:53:20 INFO - 'TERM': 'linux', 08:53:20 INFO - 'TMOUT': '86400', 08:53:20 INFO - 'USER': 'cltbld', 08:53:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:20 INFO - '_': '/tools/buildbot/bin/python'} 08:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:21 INFO - Running setup.py (path:/tmp/pip-03XHYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:21 INFO - Running setup.py (path:/tmp/pip-5AdCMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:21 INFO - Running setup.py (path:/tmp/pip-tuCpMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:21 INFO - Running setup.py (path:/tmp/pip-nOU3Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:21 INFO - Running setup.py (path:/tmp/pip-tEwxtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:21 INFO - Running setup.py (path:/tmp/pip-Wqw9Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:21 INFO - Running setup.py (path:/tmp/pip-6IX7Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:21 INFO - Running setup.py (path:/tmp/pip-SFCFMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:21 INFO - Running setup.py (path:/tmp/pip-kVrC7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:21 INFO - Running setup.py (path:/tmp/pip-dDtBAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:21 INFO - Running setup.py (path:/tmp/pip-CvqEN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:21 INFO - Running setup.py (path:/tmp/pip-43ceQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:21 INFO - Running setup.py (path:/tmp/pip-ZTlwRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:22 INFO - Running setup.py (path:/tmp/pip-YH1kvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:22 INFO - Running setup.py (path:/tmp/pip-XKFSTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:22 INFO - Running setup.py (path:/tmp/pip-remaf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:22 INFO - Running setup.py (path:/tmp/pip-_ezqpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:22 INFO - Running setup.py install for manifestparser 08:53:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozcrash 08:53:22 INFO - Running setup.py install for mozdebug 08:53:22 INFO - Running setup.py install for mozdevice 08:53:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozfile 08:53:22 INFO - Running setup.py install for mozhttpd 08:53:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozinfo 08:53:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozInstall 08:53:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozleak 08:53:23 INFO - Running setup.py install for mozlog 08:53:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for moznetwork 08:53:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozprocess 08:53:23 INFO - Running setup.py install for mozprofile 08:53:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozrunner 08:53:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Running setup.py install for mozscreenshot 08:53:23 INFO - Running setup.py install for moztest 08:53:24 INFO - Running setup.py install for mozversion 08:53:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:24 INFO - Cleaning up... 08:53:24 INFO - Return code: 0 08:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:24 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:24 INFO - Using env: {'DISPLAY': ':0', 08:53:24 INFO - 'HOME': '/home/cltbld', 08:53:24 INFO - 'LANG': 'en_US.UTF-8', 08:53:24 INFO - 'LANGUAGE': 'en_US:en', 08:53:24 INFO - 'LOGNAME': 'cltbld', 08:53:24 INFO - 'MAIL': '/var/mail/cltbld', 08:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:24 INFO - 'MOZ_NO_REMOTE': '1', 08:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:24 INFO - 'NO_EM_RESTART': '1', 08:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:24 INFO - 'PWD': '/builds/slave/test', 08:53:24 INFO - 'SHELL': '/bin/bash', 08:53:24 INFO - 'SHLVL': '1', 08:53:24 INFO - 'TERM': 'linux', 08:53:24 INFO - 'TMOUT': '86400', 08:53:24 INFO - 'USER': 'cltbld', 08:53:24 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:24 INFO - '_': '/tools/buildbot/bin/python'} 08:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:24 INFO - Running setup.py (path:/tmp/pip-r_TcEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:24 INFO - Running setup.py (path:/tmp/pip-TtEfdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:24 INFO - Running setup.py (path:/tmp/pip-DpErjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:24 INFO - Running setup.py (path:/tmp/pip-G7jI7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:24 INFO - Running setup.py (path:/tmp/pip-2eaJVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:24 INFO - Running setup.py (path:/tmp/pip-PpIFAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:24 INFO - Running setup.py (path:/tmp/pip-LzGCW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:24 INFO - Running setup.py (path:/tmp/pip-wpHvBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:24 INFO - Running setup.py (path:/tmp/pip-AwPrqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:25 INFO - Running setup.py (path:/tmp/pip-IS1fbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:25 INFO - Running setup.py (path:/tmp/pip-4DzPOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:25 INFO - Running setup.py (path:/tmp/pip-4p4ssn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:25 INFO - Running setup.py (path:/tmp/pip-8yf3zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:25 INFO - Running setup.py (path:/tmp/pip-WqBWIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 INFO - Running setup.py (path:/tmp/pip-Or_gaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Running setup.py (path:/tmp/pip-lZCPml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Running setup.py (path:/tmp/pip-peO4kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:27 INFO - Downloading blessings-1.6.tar.gz 08:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:27 INFO - Installing collected packages: blessings 08:53:27 INFO - Running setup.py install for blessings 08:53:27 INFO - Successfully installed blessings 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:28 INFO - Reading from file tmpfile_stdout 08:53:28 INFO - Current package versions: 08:53:28 INFO - argparse == 1.2.1 08:53:28 INFO - blessings == 1.6 08:53:28 INFO - blobuploader == 1.2.4 08:53:28 INFO - docopt == 0.6.1 08:53:28 INFO - functools32 == 3.2.3-2 08:53:28 INFO - jsonschema == 2.5.1 08:53:28 INFO - manifestparser == 1.1 08:53:28 INFO - mozInstall == 1.12 08:53:28 INFO - mozcrash == 1.0 08:53:28 INFO - mozdebug == 0.1 08:53:28 INFO - mozdevice == 0.49 08:53:28 INFO - mozfile == 1.2 08:53:28 INFO - mozhttpd == 0.7 08:53:28 INFO - mozinfo == 0.9 08:53:28 INFO - mozleak == 0.1 08:53:28 INFO - mozlog == 3.4 08:53:28 INFO - moznetwork == 0.27 08:53:28 INFO - mozprocess == 0.25 08:53:28 INFO - mozprofile == 0.28 08:53:28 INFO - mozrunner == 6.13 08:53:28 INFO - mozscreenshot == 0.1 08:53:28 INFO - mozsystemmonitor == 0.3 08:53:28 INFO - moztest == 0.8 08:53:28 INFO - mozversion == 1.4 08:53:28 INFO - psutil == 3.1.1 08:53:28 INFO - requests == 1.2.3 08:53:28 INFO - wsgiref == 0.1.2 08:53:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:53:28 INFO - Using env: {'DISPLAY': ':0', 08:53:28 INFO - 'HOME': '/home/cltbld', 08:53:28 INFO - 'LANG': 'en_US.UTF-8', 08:53:28 INFO - 'LANGUAGE': 'en_US:en', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MAIL': '/var/mail/cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SHLVL': '1', 08:53:28 INFO - 'TERM': 'linux', 08:53:28 INFO - 'TMOUT': '86400', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - '_': '/tools/buildbot/bin/python'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x1f071f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, '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': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:28 INFO - Using env: {'DISPLAY': ':0', 08:53:28 INFO - 'HOME': '/home/cltbld', 08:53:28 INFO - 'LANG': 'en_US.UTF-8', 08:53:28 INFO - 'LANGUAGE': 'en_US:en', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MAIL': '/var/mail/cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SHLVL': '1', 08:53:28 INFO - 'TERM': 'linux', 08:53:28 INFO - 'TMOUT': '86400', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - '_': '/tools/buildbot/bin/python'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Running post-action listener: _resource_record_post_action 08:53:28 INFO - Running post-action listener: _start_resource_monitoring 08:53:28 INFO - Starting resource monitoring. 08:53:28 INFO - [mozharness: 2017-03-19 15:53:28.606572Z] Finished create-virtualenv step (success) 08:53:28 INFO - [mozharness: 2017-03-19 15:53:28.607160Z] Running install step. 08:53:28 INFO - Running pre-action listener: _resource_record_pre_action 08:53:28 INFO - Running main action method: install 08:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:28 INFO - Reading from file tmpfile_stdout 08:53:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:28 INFO - Reading from file tmpfile_stdout 08:53:28 INFO - Output received: 08:53:28 INFO - Usage: mozinstall [options] installer 08:53:28 INFO - Options: 08:53:28 INFO - -h, --help show this help message and exit 08:53:28 INFO - -d DEST, --destination=DEST 08:53:28 INFO - Directory to install application into. [default: 08:53:28 INFO - "/builds/slave/test"] 08:53:28 INFO - --app=APP Application being installed. [default: firefox] 08:53:28 INFO - mkdir: /builds/slave/test/build/application 08:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:53:44 INFO - Reading from file tmpfile_stdout 08:53:44 INFO - Output received: 08:53:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:53:44 INFO - Running post-action listener: _resource_record_post_action 08:53:44 INFO - [mozharness: 2017-03-19 15:53:44.326276Z] Finished install step (success) 08:53:44 INFO - [mozharness: 2017-03-19 15:53:44.326549Z] Running run-tests step. 08:53:44 INFO - Running pre-action listener: _resource_record_pre_action 08:53:44 INFO - Running main action method: run_tests 08:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:44 INFO - Python 2.7.3 08:53:44 INFO - Return code: 0 08:53:44 INFO - grabbing minidump binary from tooltool 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 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 0x21a2290>, '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 0x21a2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a3040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:53:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:53:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:44 INFO - Return code: 0 08:53:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:53:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - ENV: RUST_BACKTRACE is now 1 08:53:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:53:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:53:44 INFO - Using env: {'DISPLAY': ':0', 08:53:44 INFO - 'HOME': '/home/cltbld', 08:53:44 INFO - 'LANG': 'en_US.UTF-8', 08:53:44 INFO - 'LANGUAGE': 'en_US:en', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MAIL': '/var/mail/cltbld', 08:53:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:44 INFO - 'RUST_BACKTRACE': '1', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SHLVL': '1', 08:53:44 INFO - 'TERM': 'linux', 08:53:44 INFO - 'TMOUT': '86400', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - '_': '/tools/buildbot/bin/python'} 08:53:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:53:44 INFO - mozversion application_buildid: 20170319152412 08:53:44 INFO - mozversion application_changeset: 51844ae447dbc52cec81abb4c1a6e676b905a743 08:53:44 INFO - mozversion application_display_name: Nightly 08:53:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:44 INFO - mozversion application_name: Firefox 08:53:44 INFO - mozversion application_remotingname: firefox 08:53:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:53:44 INFO - mozversion application_vendor: Mozilla 08:53:44 INFO - mozversion application_version: 55.0a1 08:53:44 INFO - mozversion platform_buildid: 20170319152412 08:53:44 INFO - mozversion platform_changeset: 51844ae447dbc52cec81abb4c1a6e676b905a743 08:53:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:53:44 INFO - mozversion platform_version: 55.0a1 08:53:44 INFO - using testdate: 1489938824 08:53:44 INFO - actual date: 1489938824 08:53:44 INFO - starting webserver on 'localhost:49870' 08:53:44 INFO - SUITE-START | Running 2 tests 08:53:44 INFO - TEST-START | dromaeo_css 08:53:44 INFO - operating with platform_type : linux_ 08:53:44 INFO - Initialising browser for dromaeo_css test... 08:53:44 INFO - TEST-INFO | started process 2684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ618Be/profile http://localhost:49870/getInfo.html) 08:53:49 INFO - PID 2684 | __metrics Screen width/height:1600/1200 08:53:49 INFO - PID 2684 | colorDepth:24 08:53:49 INFO - PID 2684 | Browser inner width/height: 1024/697 08:53:49 INFO - PID 2684 | __metrics 08:53:50 ERROR - PID 2684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:53:51 INFO - TEST-INFO | 2684: exit 0 08:53:51 INFO - Browser initialized. 08:53:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:51 INFO - TEST-INFO | started process 2919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ618Be/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:04 INFO - PID 2919 | RSS: Main: 155082752 08:54:04 INFO - PID 2919 | 08:57:09 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49870/tests/dromaeo/cssquery-ext.html) 08:57:10 INFO - PID 2919 | RSS: Main: 165539840 08:57:10 INFO - PID 2919 | 08:58:52 INFO - PID 2919 | ************************* 08:58:52 INFO - PID 2919 | A coding exception was thrown and uncaught in a Task. 08:58:52 INFO - PID 2919 | 08:58:52 ERROR - PID 2919 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:58:52 INFO - PID 2919 | Full stack: 08:58:52 INFO - PID 2919 | ************************* 09:00:12 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-ext.html (next: http://localhost:49870/tests/dromaeo/cssquery-jquery.html) 09:00:13 INFO - PID 2919 | RSS: Main: 161185792 09:00:13 INFO - PID 2919 | 09:03:15 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49870/tests/dromaeo/cssquery-mootools.html) 09:03:16 INFO - PID 2919 | RSS: Main: 169611264 09:03:16 INFO - PID 2919 | 09:06:18 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49870/tests/dromaeo/cssquery-prototype.html) 09:06:18 INFO - PID 2919 | RSS: Main: 161107968 09:06:18 INFO - PID 2919 | 09:09:21 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49870/tests/dromaeo/cssquery-yui.html) 09:09:22 INFO - PID 2919 | RSS: Main: 168583168 09:09:22 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | Cycle 1(1): loaded http://localhost:49870/tests/dromaeo/cssquery-yui.html (next: http://localhost:49870/tests/dromaeo/cssquery-dojo.html) 09:12:25 INFO - PID 2919 | RSS: Main: 162324480 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | __start_tp_report 09:12:25 INFO - PID 2919 | _x_x_mozilla_page_load 09:12:25 INFO - PID 2919 | _x_x_mozilla_page_load_details 09:12:25 INFO - PID 2919 | |i|pagename|runs| 09:12:25 INFO - PID 2919 | |0;dojo.html;2664.8534330611833;2668.03950577792;2681.852498112603;2706.7969902257323;2721.618973343731;4922.261660750889;4928.556429921311;4966.10610090184;4971.304017437553;4999.500049994998;4927.5072492750705;4958.082754690376;5022.447530771612;5029.7988080476825;5039.5716364109;4199.202151591188;4474.373587697725;4518.593326600605;4520.480144783359;4635.860924172263;4533.2066888294585;4550.840720574781;4592.954070459303;4597.011642496863;4601.838935637254;4443.4445694288215;4503.144402563503;4512.052468981517;4577.862664120048;4601.401817763703;4535.750533720644;4535.841245556389;4551.590356867865;4595.770211489412;4606.746628935407;4487.730736155809;4490.730556166608;4509.7970591323465;4510.548945105464;4584.9541504585195;4788.377510923592;4848.781804818792;4946.109700253953;4957;4989.501049895018;5282.102042652758;5293.708846013467;5297.417284098746;5318.787248510055;5326.493983071602;5317.680939143664;5325.041492531343;5329.493698098674;5334.839954801362;5372.811951581676;4875.366202393737;4939.678920870204;4941.283513890466;4941.925871111936;4947.975260123676;5290.788368465218;5453.809116680976;5500.642458240201;5522.978249023863;5558.194061861008;5151.22731590257;5221.55616772571;5280.075986702312;5282.128448805904;5284.313039304942;5285;5319.813806516753;5332;5332.600054995891;5338.91991620126;5136.974315128476;5155.845324640267;5182.119039763249;5280.498352656491;5282.894342113136;5289.497497737709;5292.232626269247;5292.994331077083;5313.654612450178;5330.706811125426;4516.412866327357;4527.1172121436;4531.637469002472;4531.682782205214;4569.817207311737;3861.7296789225047;3876.8255428505786;3912;3921.9019524511546;3928.253631809947;4631.073785242897;4652.209124448852;4655.464621568563;4676.041411510632;4696.248600224016;5326.733663316819;5333.651285719951;5348.652337598043;5356.7321633918145;5384.730763461811;4528.660350473728;4632.5830675239395;4638.257878739386;4641.071785642885;4696.342512048316;4705.976470117627;4716.858494245178;4717.858464246078;4720.33915251865;4730.455997560256;4860.513948605111;4891.584215341736;4902.01959608087;4903.779329930233;4907.803687852446;5222.9216561750845;5269.420363759907;5322.946770532245;5324;5324.653897496651;4927.236278376858;4952.306677065286;4953.2074868020945;4969.3291405659775;4975.950240497548;5157.690538567698;5175.870603234949;5184.377874655065;5231.503007214308;5235.476452354734;5320.760565774627;5355.785768569213;5367.865803354791;5390.110631745718;5413.83758487246;5139.331886854685;5148.613853961043;5161.948380516147;5188.714620695898;5189.273501709839;5123.308353372247;5157.690538567698;5163.690178589297;5175.9741201293755;5189.506996835295;4929.704217746947;4996;5090.4655011223285;5107.8507335849135;5120.436751957356;5157.716325602128;5162.09663308927;5166.638335316492;5185.040767458032;5232.529072383504;4985.451600324034;4999.0251900878975;5011.674241174312;5022.422421421583;5033.597312214941 09:12:25 INFO - PID 2919 | |1;ext.html;647.4270270810331;691.3397705191543;711.4024219655488;857.4126723194612;870.0168809245552;33965.83017084914;34747.82626086869;34835.12912177197;34872.825635871784;34882.30235395294;30950.380992380196;31305.373892522137;31326.216844578896;31423.214419639462;31424.371512569734;6328.430441260297;6558.049082882979;8913.910860891372;9235.861462078074;9254.352195346328;9319.767005824875;9382.202512786387;9467.195288400495;9476.952615236914;9479.810403791955;9436.716898493021;9463.10100540451;9496.762580935463;9551.665691700791;9556.856647150298;9394.530273486333;9439.575219115088;9460.432374057544;9464.905350946472;9474.526273686288;9195.862062069074;9328.95335523318;9334.113259240428;9342.719718408458;9355.532223388804;34971.1257218569;35310.82344588287;35389;35673.1081722959;35801.64198358009;3235.7573182011442;3308.1894935740656;3328.916777080568;3338.6828251316088;3382.9323413531592;23446.296611101694;23733.643995340084;23847.92684329192;24176.758232417626;24614.630780538308;3375.7299416046903;3422.9486557701653;3431.6396778338412;3463.8960831175104;3493.8951831444842;156936;157531;158389.20805396014;158438;159123;43056.56943430525;43125;43170;43357;43393.78303108464;44727.55272447234;45064.3240351395;45140;45168.548314517095;45272.773636131606;11898.702532436759;12132.69668258283;12161.695957600954;12223;12255.387230638433;9577.329586928987;9640.951795241119;9655.420674759536;9663.855042174373;9668.196223095223;13548.729025419634;13564.253966031964;13632;13788.93105534466;13885;5571.303587051619;5672.8865422691315;5679.176519404746;5726.398728133486;5739.306904463193;997.3716558568055;1014.0518615094762;1027.5941003303653;1042.4475028235047;1043.76515284062;22533.661995070088;22619.43451413728;22683.659745103836;22754.311422144463;23058.76941230566;1070.4754670211696;1085.3596378136779;1088.6244245735209;1114.0641860836774;1117.6032508459543;11188.832167517494;12079.57721479744;12115.273083615011;12179.756404871852;12260.26438413698;213111;213968;214026;215390;215745;43572;44199.558004420185;44235.33646995298;44346.33480497795;44422.777886111006;1093.10365500289;1181.7931861924128;1226.1723336747839;1227.1042139238407;1300.388817255907;22103.44741381478;24108.638370424105;24737.257882263562;24742.87628561846;24807.379815504755;29339.266518337212;29543;29568.704312956594;29631.407371852874;29903.252418689706;170551;170785;171016;171128;171168;27629.585556217076;27649.585256221577;27729.168124956283;27845.44309113847;27913;32536.34927301488;32736;33000.834995824865;33154.33691326208;33486.497702534965;29960.85019574888;30605;31897.202569935936;31955.520667190474;31966.68033319637;30699;30870.69129308768;31182.68817311798;31225.8438707805;31827.522587161675;29066;29267.56098658479;29653.25866853346;30201.546976795806;30530.84734576313;24859.875700621382;26096.478070438105;27864.721352787023;28576.428471430037;28801.279968000967;22286.331410057723;22677.886610566842;22734.886325568266;22903.08387664475;22928.656070159293 09:12:25 INFO - PID 2919 | |2;jquery.html;407.78998815609987;415.34583031725043;419.45680343954575;436.96285815705664;437.9321205213191;15681;17747.201375938082;18165.909170454128;18207.453776386712;18211.08944552772;17002;17240.655186896256;17324.480265592054;17376.131193440342;17392.82607173928;5240.528352448279;5343.118385466403;5470.206820011096;5627.2684551008315;5671.347795003566;5535.169724541331;5603.495685388314;5618.943810561883;5624.91562626561;5639.520640745542;5599.552035837123;5602.971985140069;5611.7474713637785;5631.859203519924;5643.661380317194;5484.341878974528;5652.98246315663;5663.660180389169;5665.1502274658715;5670.404607516234;5519.31008623922;6260;6529.869402611968;6539.08452816606;6559.917613593751;21290.848284584514;21634.78365216359;21830.345089647337;22178.556428871492;22270.438899526598;2277.7380601230907;2282.646189840561;2296.7588403217756;2300.1029598456616;2353.2822489140804;12653.810192847115;12823.935880320632;13722.725545489035;14127.15237085778;14356.210408427532;1852.5090850924516;1931.5364312565023;1952.4240349097051;1952.4923519884933;1957.3051566693762;83702.58148709279;84190.57904710498;84326;84372.57813710954;86654.56672716659;16116.75824862628;16277.67444651124;16365.83634163667;16426.75359869603;16504.33982640705;27845.164645060682;27914.441711165662;28090.71909280922;28143;28170.19702340158;8118.512889226666;8252.504849708917;8287;8523.232909038215;8582.82834343322;6733.3939945405145;6763.222229443677;6900.2409734929115;6959.582425054513;7006.299370062953;8699.652013919498;8736.388452808242;8855.51294678786;8932;9094.681686140953;3334.216459132102;3435.7766745161484;3489.5114683944266;3564.3821521156046;3684.373656478405;817.8200795824908;844.7550210439027;851.5614458553849;861.0958493581714;887.7603047177226;17432;17473;18389.264429422674;18611.441656750318;20149.597008059758;847.9745607631781;859.9484030958163;861.1044513705801;873.6287077991828;890.3144578674514;6374.776882809079;6536.150300461005;6547.410733034049;6605.834854128685;6772.085768421299;488794;490643;493865;497174;503072;85801;85946;86871.56564217138;87260.5636971811;89419;1077.6012875236213;1101.4657890922897;1145.7364806094479;1146.1232157399595;1150.2121047082776;16138;16400;17034.126246113166;17085.402010929556;17322.48032558975;37701.62298377091;38593.42109868298;42023.7898810504;42883.35674964941;43716.34425483557;55167.72416137894;56145;56293.43706562882;56395;56796.14805777834;10659.626913058006;10683.450899619667;10689.625863094754;10847.566097356017;11281.153913456688;12128.696782580506;12534.373281336078;12540.247585144556;12607.873921261036;12741.617751467471;10680.679579612624;10686.145108391465;11087.944560277147;11233.48347973046;11235.943820280847;10150.238732094975;10519.26365154432;10539.26225164231;10616.522256498321;10884.61903833362;10526.421036844535;10728.785424291627;10790.946045269724;10888.891111089104;11281.71795705081;10636.30863993838;10721.249512534048;10902.40036797952;10923.180761442765;11269.436528173395;10534.315269507457;10695.625653102104;10828.5127169276;10925.289856159325;10983.286086404358 09:12:25 INFO - PID 2919 | |3;mootools.html;1450.2386247220202;1474.5502621700384;1485.5394827603436;1502.0311898825257;1562.1720488141286;7784.299413052824;8086.878696819553;8902.732918012462;9288.4426934384;9311.580978855942;9180.8622870657;9487.525623718804;9493.382930109537;9504;9543;2059.1454546363243;2112.4613223627953;2114.4608124928122;2115.936521904345;2115.957680846382;1968.1045124468403;1975.87156834806;1986.73179120819;1996.161612122912;2007.8895660738654;2015.707722380254;2018.0716870239708;2032.2683833819813;2033.0343087033689;2033.7356143701297;1926.1236137557378;1933.468296218537;1933.7389452423884;1934.5453818352676;1937.4671965209538;1942.786293507713;1987.2647120565339;2005.2380095563738;2013.9194432222694;2025.6151331247015;9707.466089365082;9729.318947673666;9778.462184579845;9782.461964591945;9787.021297870227;4578.427696537933;4696.483386827446;4770.998090400985;4771.260454629538;4786.282057691339;2494.7006359237007;2598.6751656042993;2658.2689760315875;2729.0993971989396;2729.372244383803;947.9194268487187;993.3692105512979;1013.6300250408548;1020.4693559349097;1022.0545994954712;14342.856571434257;14427.567172984827;14442.422303107864;14472.348744306531;14481.493147739779;3960.4653371795016;4090.4886889138857;4170.645495132948;4194.916101677949;4314.848980285675;11821.940890295493;11848.170628055954;11893.821592676117;11921.463534140985;11938.940305298418;4977;4986.950130498649;4990.5508504234795;4999.950000499948;5011.699298042129;3614.331348700499;3844.38489841624;4229.577042295808;4326.437563116838;4457.710248833815;3471.704905083096;3495.475678648223;3497.8107443469344;3522.365974124682;3574.3208790329754;1004.1314263162312;1004.3622299839654;1005.2661557063385;1020.1430798129607;1023.2734758321526;844.7676888855491;853.9274161696201;859.7034023261965;878.424631866116;884.9557522123868;5478.753456094485;5623;5661.547076233891;5753.108268218432;5897.823065308047;889.2619126125301;902.6267732834407;903.1375036839802;906.9047749986288;919.5815903763771;3492.2840817632323;3503.2818272254126;3569.089882080053;3716.349638813197;3977.980110099431;11574.537018519333;11851.288922664495;12083.818742718866;12259.141860069709;12285.140040197279;12125.939370303093;12150.33173175466;12171.896166477492;12196.939015305044;12210.511579536897;8434.409591328671;8485.0666426693;8810.339224558184;8824.77938051541;8831;5678.290213723285;5792.797252096157;5840.620359676607;5967.134765458897;6013.067974463965;10907.563697452331;10908.290961087503;10926.890731092906;11004.779904402027;11029.283096598696;10371;10524.684259472227;10528.683689588279;10671.413072280788;10715.35707857531;6565.704543295467;6777.322267773183;7677.654505547152;7745.496542724705;7971.601419929097;9085.182333590008;9194.218491428304;9207.355485116246;9217.170454658844;9231.307651926267;7585.6965721370525;7619.1999840016;7846.882296765667;7880.3301719354495;8024.438289319692;7884.21157884207;7983.560904150328;8118.797030074295;8143.79640508992;8231.917680823115;7183.928160718535;7196.4962452627815;7220.602866842374;7260.564366138048;7296.854062918818;5246.160614301693;5300.814471493633;5363.141897296414;5407.86480337979;5440.483154100354;4860.8298709545;4962.5533701967;5020.949790502048;5249.580033597226;5306.8938621228135 09:12:25 INFO - PID 2919 | |4;prototype.html;371.7472118959108;391.2507548045493;392.61327592321567;402.3481959226052;402.50692901196055;5189.948100518994;5369.09397164007;5420.349558053029;5491.780328786854;5492.972535137329;5168.689878607286;5331.2003199520095;5373.596980226479;5387.946120538793;5393.298871146755;4644.210484217691;4648.9767551162195;4658.9068218635775;4663.27719203524;4676.415448068991;4564.475085365176;4611.746353950532;4625.398698169233;4650.930236046462;4658.604018658418;4605.8024913522395;4606.884827879297;4607.953920460803;4624.768761561909;4625.167469855424;4596.494385617613;4608.3778689876945;4625.236835922069;4636.884077898063;4659.534046595347;4387.517373088957;4408.693479890082;4420.491643461011;4477.955220447787;4482.260427029536;5204.817831375922;5240;5250.369955605313;5251.396089449724;5284.788608455658;5407.432219616962;5438.782448702047;5438.8912221755345;5439.47064614956;5448.645838020516;5581.5813813963705;5658.91511627326;5708.857278568027;5720.856978575569;5761.971190144064;4860.756962151913;4872.488388719169;4905.558499735005;4910.263460480921;4915.606751459874;5759.769609215627;5796.710164491758;5932.614380065282;6031.52707389968;6082.343420618823;5021.171506701427;5125.282460455539;5127.6154288428515;5128.333316668809;5136.229565565195;5245.527902488794;5245.842624721265;5251.816186433456;5258.290130832289;5258.894822103536;5309.787608495617;5378.489043540857;5383.838484845461;5409.161579955114;5436.891262174734;5685.857853553612;5689.886202276014;5708.715539003774;5710.37185909558;5714.114312281603;1579.8499142581436;1816.7638207033;1846.6150387209593;1850.2691436882626;1851.2039822876293;1226.1233218248994;1234.7098431868503;1261.2621616354536;1275.3113318807925;1280.711839836048;4910.238912968495;4919.794650310625;4932.67937584063;4939.283803848493;4949;5802.1296805479515;5805.274340707411;5809.2738407699035;5813.767449302065;5813.912791308134;4683;4929.556339929423;4935.531124543163;4950.876228094255;4955;3074.6003019607756;3098;3107.285324375406;3112.517559778238;3113.4395808754643;5406.135018397116;5438.3473983121485;5442.455754424605;5443.346798384219;5456.706994215605;5685.488306052475;5950.67271300074;5965.13505541694;5986.6707331097205;5995.700214989233;5405.540529054996;5412.5940554458575;5412.972935135378;5419.566434685295;5432.701201433959;5613.803516876889;5778.971105144447;5798.449147330997;5823.475887170175;5833.191710569737;5492.697901615449;5664.518515926193;5761.48146666802;5804.736152900457;5818.9525885341045;5325.97337013328;5477.20580515831;5489.972550137224;5498.697571633598;5504.4495550444635;4656.8602941911795;4683.976580117078;4695.600873925755;4708.529147085264;4711.222648263135;5777.3933736957015;5849.1226316052935;5866.208061911588;5873.119032145212;5894.705264736832;5656.943430565641;5669.886602267849;5672.808710170911;5681.0910254359105;5685.20407142992;5481.588880834033;5681.0910254359105;5700.686462244616;5720.599558030898;5731.111677689964;5545.500904918576;5589.9379117967455;5590.161475778666;5598.748056337393;5611.354694210218;5703.144528320785;5726.484616384545;5738.913916291175;5745.396733343106;5747.166660834239;5397.406285308692;5505.917411238915;5544.889102218014;5562.527185189142;5591.217229587943 09:12:25 INFO - PID 2919 | |5;yui.html;618.5608218165103;629.9811005669832;665.9633720145393;674.8076798112537;682.5666498931313;12434.25394476331;12556.874431255696;12601.495940162395;13620.591382258523;14265.072770269951;12450.750984980317;12607.558735444261;12614.684632884182;12622.558210462636;12626.873731262707;817.9345652347813;840.0591337701783;841.9915800842005;842.8314337132598;844.2401838345477;810.027966440274;835.4068611285994;845.6110189312924;846.4751853850621;853.3812985585463;872.9825403491926;873.598144853365;878.3939082033409;880.6697488441835;882.2897567458193;873.6985739919718;875.369733791669;878.0911756332198;880.9603567839431;889.0131953531575;647.423792824382;647.4949539359308;647.773279352223;651.8891788395985;652.9379708927644;13943.16341019542;14286.71426571473;14298.356573954197;14302.71394572113;14725.852741472663;13338.333083345793;13834;13935.721285574231;13972.580822575339;13988.860111398857;9325.673601423985;10313.226508011929;10380.584776608926;10403.427811470367;10433.269671123024;3180.6024246969127;3204.83975801209;3208.4385232584436;3235;3246.1559994401628;35431.822840885885;37903.81048094769;46092.53907460916;48844.75577622089;49852;10867.40229287381;11169;11268.718282043015;11400.087992960709;11546.59586914454;21373.67939480909;21445;21568.784312156993;21698.78301216999;21929.23247686323;6800.387965083166;6894.724211031503;6934.16789985205;6985.26654701249;7165.593160206436;3284.9671503284662;3363.646817084171;3401.795892246473;3412.931741365159;3483.54713887193;2600.1939398786435;2675.3712877473777;2699.973000269972;2700.338417087826;2712.891484340604;446.3973635591925;447.9888002799956;450.8692479181066;451.9231730605805;458.01298202373937;642.7782415066795;655.2039272284197;666.1107421592228;675.8411773233287;681.8363592737807;7869.842603148019;8291.253787159185;8355.164483551596;8549.914500854911;8889.377743558018;623.183629445428;640.8365866703961;662.215274899246;662.8641128568631;666.8499587592753;3660.524131862894;3738.457923601117;3821.6751576115785;3895.1820117775583;3917.882463526099;46086;49428.258576121385;58385.70807146022;60560;60661.69669151714;52576.47423525792;53520.46479535232;54771.17843232355;55290.72354638201;55778;46829.76585117121;47891.28163077487;47936.7603161982;48360.516394836304;49485;7297.562146271241;7413.406927445899;7467.477276590804;7479.401647868049;7588.81027974305;34119.4882076774;34592.48111278383;35092.298154037286;35137;35506.467402989496;38729.6127038726;39479.2104157921;39867;40889.38665919954;41318.1736365265;9178.586963586522;9644.083812037845;9652.372595781251;9721.562529686322;9744.902550974683;8868.778280543038;9010.594523246338;9023.097690230925;9095.636174552943;9127.863082053642;9302.581383837609;9324.766880828034;9404.764880878032;9455.338126331091;9856.605735770776;9829.803403931739;9926.15627671656;10021.899781002097;10328.845067324146;10364.481775911325;9641.079904767088;9855.31012829095;10037.949810250902;10103.545340459845;10379.325343852626;8195.426320157532;8533.786655333419;8551.35864810154;8561.57192140378;8782.956085219534;7787.961060194662;7965.283124518821;8039.276465118168;8253.215944485264;8417.663293468438 09:12:25 INFO - PID 2919 | __end_tp_report 09:12:25 INFO - PID 2919 | __start_cc_report 09:12:25 INFO - PID 2919 | _x_x_mozilla_cycle_collect,396 09:12:25 INFO - PID 2919 | __end_cc_report 09:12:25 INFO - PID 2919 | __startTimestamp1489939945476__endTimestamp 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | ------- Summary: start ------- 09:12:25 INFO - PID 2919 | Number of tests: 6 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#0] dojo.html Cycles:165 Average:4890.38 Median:4989.50 stddev:526.81 (10.6%) stddev-sans-first:498.66 09:12:25 INFO - PID 2919 | Values: 2664.9 2668.0 2681.9 2706.8 2721.6 4922.3 4928.6 4966.1 4971.3 4999.5 4927.5 4958.1 5022.4 5029.8 5039.6 4199.2 4474.4 4518.6 4520.5 4635.9 4533.2 4550.8 4593.0 4597.0 4601.8 4443.4 4503.1 4512.1 4577.9 4601.4 4535.8 4535.8 4551.6 4595.8 4606.7 4487.7 4490.7 4509.8 4510.5 4585.0 4788.4 4848.8 4946.1 4957.0 4989.5 5282.1 5293.7 5297.4 5318.8 5326.5 5317.7 5325.0 5329.5 5334.8 5372.8 4875.4 4939.7 4941.3 4941.9 4948.0 5290.8 5453.8 5500.6 5523.0 5558.2 5151.2 5221.6 5280.1 5282.1 5284.3 5285.0 5319.8 5332.0 5332.6 5338.9 5137.0 5155.8 5182.1 5280.5 5282.9 5289.5 5292.2 5293.0 5313.7 5330.7 4516.4 4527.1 4531.6 4531.7 4569.8 3861.7 3876.8 3912.0 3921.9 3928.3 4631.1 4652.2 4655.5 4676.0 4696.2 5326.7 5333.7 5348.7 5356.7 5384.7 4528.7 4632.6 4638.3 4641.1 4696.3 4706.0 4716.9 4717.9 4720.3 4730.5 4860.5 4891.6 4902.0 4903.8 4907.8 5222.9 5269.4 5322.9 5324.0 5324.7 4927.2 4952.3 4953.2 4969.3 4976.0 5157.7 5175.9 5184.4 5231.5 5235.5 5320.8 5355.8 5367.9 5390.1 5413.8 5139.3 5148.6 5161.9 5188.7 5189.3 5123.3 5157.7 5163.7 5176.0 5189.5 4929.7 4996.0 5090.5 5107.9 5120.4 5157.7 5162.1 5166.6 5185.0 5232.5 4985.5 4999.0 5011.7 5022.4 5033.6 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#1] ext.html Cycles:180 Average:33061.79 Median:31265.61 stddev:47178.87 (150.9%) stddev-sans-first:47248.44 09:12:25 INFO - PID 2919 | Values: 647.4 691.3 711.4 857.4 870.0 33965.8 34747.8 34835.1 34872.8 34882.3 30950.4 31305.4 31326.2 31423.2 31424.4 6328.4 6558.0 8913.9 9235.9 9254.4 9319.8 9382.2 9467.2 9477.0 9479.8 9436.7 9463.1 9496.8 9551.7 9556.9 9394.5 9439.6 9460.4 9464.9 9474.5 9195.9 9329.0 9334.1 9342.7 9355.5 34971.1 35310.8 35389.0 35673.1 35801.6 3235.8 3308.2 3328.9 3338.7 3382.9 23446.3 23733.6 23847.9 24176.8 24614.6 3375.7 3422.9 3431.6 3463.9 3493.9 156936.0 157531.0 158389.2 158438.0 159123.0 43056.6 43125.0 43170.0 43357.0 43393.8 44727.6 45064.3 45140.0 45168.5 45272.8 11898.7 12132.7 12161.7 12223.0 12255.4 9577.3 9641.0 9655.4 9663.9 9668.2 13548.7 13564.3 13632.0 13788.9 13885.0 5571.3 5672.9 5679.2 5726.4 5739.3 997.4 1014.1 1027.6 1042.4 1043.8 22533.7 22619.4 22683.7 22754.3 23058.8 1070.5 1085.4 1088.6 1114.1 1117.6 11188.8 12079.6 12115.3 12179.8 12260.3 213111.0 213968.0 214026.0 215390.0 215745.0 43572.0 44199.6 44235.3 44346.3 44422.8 1093.1 1181.8 1226.2 1227.1 1300.4 22103.4 24108.6 24737.3 24742.9 24807.4 29339.3 29543.0 29568.7 29631.4 29903.3 170551.0 170785.0 171016.0 171128.0 171168.0 27629.6 27649.6 27729.2 27845.4 27913.0 32536.3 32736.0 33000.8 33154.3 33486.5 29960.9 30605.0 31897.2 31955.5 31966.7 30699.0 30870.7 31182.7 31225.8 31827.5 29066.0 29267.6 29653.3 30201.5 30530.8 24859.9 26096.5 27864.7 28576.4 28801.3 22286.3 22677.9 22734.9 22903.1 22928.7 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#2] jquery.html Cycles:180 Average:29473.39 Median:3385.00 stddev:81417.05 (2405.2%) stddev-sans-first:81616.19 09:12:25 INFO - PID 2919 | Values: 407.8 415.3 419.5 437.0 437.9 15681.0 17747.2 18165.9 18207.5 18211.1 17002.0 17240.7 17324.5 17376.1 17392.8 5240.5 5343.1 5470.2 5627.3 5671.3 5535.2 5603.5 5618.9 5624.9 5639.5 5599.6 5603.0 5611.7 5631.9 5643.7 5484.3 5653.0 5663.7 5665.2 5670.4 5519.3 6260.0 6529.9 6539.1 6559.9 21290.8 21634.8 21830.3 22178.6 22270.4 2277.7 2282.6 2296.8 2300.1 2353.3 12653.8 12823.9 13722.7 14127.2 14356.2 1852.5 1931.5 1952.4 1952.5 1957.3 83702.6 84190.6 84326.0 84372.6 86654.6 16116.8 16277.7 16365.8 16426.8 16504.3 27845.2 27914.4 28090.7 28143.0 28170.2 8118.5 8252.5 8287.0 8523.2 8582.8 6733.4 6763.2 6900.2 6959.6 7006.3 8699.7 8736.4 8855.5 8932.0 9094.7 3334.2 3435.8 3489.5 3564.4 3684.4 817.8 844.8 851.6 861.1 887.8 17432.0 17473.0 18389.3 18611.4 20149.6 848.0 859.9 861.1 873.6 890.3 6374.8 6536.2 6547.4 6605.8 6772.1 488794.0 490643.0 493865.0 497174.0 503072.0 85801.0 85946.0 86871.6 87260.6 89419.0 1077.6 1101.5 1145.7 1146.1 1150.2 16138.0 16400.0 17034.1 17085.4 17322.5 37701.6 38593.4 42023.8 42883.4 43716.3 55167.7 56145.0 56293.4 56395.0 56796.1 10659.6 10683.5 10689.6 10847.6 11281.2 12128.7 12534.4 12540.2 12607.9 12741.6 10680.7 10686.1 11087.9 11233.5 11235.9 10150.2 10519.3 10539.3 10616.5 10884.6 10526.4 10728.8 10790.9 10888.9 11281.7 10636.3 10721.2 10902.4 10923.2 11269.4 10534.3 10695.6 10828.5 10925.3 10983.3 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#3] mootools.html Cycles:180 Average:5923.66 Median:4320.64 stddev:3825.11 (88.5%) stddev-sans-first:3821.07 09:12:25 INFO - PID 2919 | Values: 1450.2 1474.6 1485.5 1502.0 1562.2 7784.3 8086.9 8902.7 9288.4 9311.6 9180.9 9487.5 9493.4 9504.0 9543.0 2059.1 2112.5 2114.5 2115.9 2116.0 1968.1 1975.9 1986.7 1996.2 2007.9 2015.7 2018.1 2032.3 2033.0 2033.7 1926.1 1933.5 1933.7 1934.5 1937.5 1942.8 1987.3 2005.2 2013.9 2025.6 9707.5 9729.3 9778.5 9782.5 9787.0 4578.4 4696.5 4771.0 4771.3 4786.3 2494.7 2598.7 2658.3 2729.1 2729.4 947.9 993.4 1013.6 1020.5 1022.1 14342.9 14427.6 14442.4 14472.3 14481.5 3960.5 4090.5 4170.6 4194.9 4314.8 11821.9 11848.2 11893.8 11921.5 11938.9 4977.0 4987.0 4990.6 5000.0 5011.7 3614.3 3844.4 4229.6 4326.4 4457.7 3471.7 3495.5 3497.8 3522.4 3574.3 1004.1 1004.4 1005.3 1020.1 1023.3 844.8 853.9 859.7 878.4 885.0 5478.8 5623.0 5661.5 5753.1 5897.8 889.3 902.6 903.1 906.9 919.6 3492.3 3503.3 3569.1 3716.3 3978.0 11574.5 11851.3 12083.8 12259.1 12285.1 12125.9 12150.3 12171.9 12196.9 12210.5 8434.4 8485.1 8810.3 8824.8 8831.0 5678.3 5792.8 5840.6 5967.1 6013.1 10907.6 10908.3 10926.9 11004.8 11029.3 10371.0 10524.7 10528.7 10671.4 10715.4 6565.7 6777.3 7677.7 7745.5 7971.6 9085.2 9194.2 9207.4 9217.2 9231.3 7585.7 7619.2 7846.9 7880.3 8024.4 7884.2 7983.6 8118.8 8143.8 8231.9 7183.9 7196.5 7220.6 7260.6 7296.9 5246.2 5300.8 5363.1 5407.9 5440.5 4860.8 4962.6 5020.9 5249.6 5306.9 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#4] prototype.html Cycles:180 Average:4913.90 Median:5395.35 stddev:1278.33 (23.7%) stddev-sans-first:1235.62 09:12:25 INFO - PID 2919 | Values: 371.7 391.3 392.6 402.3 402.5 5189.9 5369.1 5420.3 5491.8 5493.0 5168.7 5331.2 5373.6 5387.9 5393.3 4644.2 4649.0 4658.9 4663.3 4676.4 4564.5 4611.7 4625.4 4650.9 4658.6 4605.8 4606.9 4608.0 4624.8 4625.2 4596.5 4608.4 4625.2 4636.9 4659.5 4387.5 4408.7 4420.5 4478.0 4482.3 5204.8 5240.0 5250.4 5251.4 5284.8 5407.4 5438.8 5438.9 5439.5 5448.6 5581.6 5658.9 5708.9 5720.9 5762.0 4860.8 4872.5 4905.6 4910.3 4915.6 5759.8 5796.7 5932.6 6031.5 6082.3 5021.2 5125.3 5127.6 5128.3 5136.2 5245.5 5245.8 5251.8 5258.3 5258.9 5309.8 5378.5 5383.8 5409.2 5436.9 5685.9 5689.9 5708.7 5710.4 5714.1 1579.8 1816.8 1846.6 1850.3 1851.2 1226.1 1234.7 1261.3 1275.3 1280.7 4910.2 4919.8 4932.7 4939.3 4949.0 5802.1 5805.3 5809.3 5813.8 5813.9 4683.0 4929.6 4935.5 4950.9 4955.0 3074.6 3098.0 3107.3 3112.5 3113.4 5406.1 5438.3 5442.5 5443.3 5456.7 5685.5 5950.7 5965.1 5986.7 5995.7 5405.5 5412.6 5413.0 5419.6 5432.7 5613.8 5779.0 5798.4 5823.5 5833.2 5492.7 5664.5 5761.5 5804.7 5819.0 5326.0 5477.2 5490.0 5498.7 5504.4 4656.9 4684.0 4695.6 4708.5 4711.2 5777.4 5849.1 5866.2 5873.1 5894.7 5656.9 5669.9 5672.8 5681.1 5685.2 5481.6 5681.1 5700.7 5720.6 5731.1 5545.5 5589.9 5590.2 5598.7 5611.4 5703.1 5726.5 5738.9 5745.4 5747.2 5397.4 5505.9 5544.9 5562.5 5591.2 09:12:25 INFO - PID 2919 | 09:12:25 INFO - PID 2919 | [#5] yui.html Cycles:180 Average:13336.10 Median:55534.36 stddev:15807.54 (28.5%) stddev-sans-first:15823.04 09:12:25 INFO - PID 2919 | Values: 618.6 630.0 666.0 674.8 682.6 12434.3 12556.9 12601.5 13620.6 14265.1 12450.8 12607.6 12614.7 12622.6 12626.9 817.9 840.1 842.0 842.8 844.2 810.0 835.4 845.6 846.5 853.4 873.0 873.6 878.4 880.7 882.3 873.7 875.4 878.1 881.0 889.0 647.4 647.5 647.8 651.9 652.9 13943.2 14286.7 14298.4 14302.7 14725.9 13338.3 13834.0 13935.7 13972.6 13988.9 9325.7 10313.2 10380.6 10403.4 10433.3 3180.6 3204.8 3208.4 3235.0 3246.2 35431.8 37903.8 46092.5 48844.8 49852.0 10867.4 11169.0 11268.7 11400.1 11546.6 21373.7 21445.0 21568.8 21698.8 21929.2 6800.4 6894.7 6934.2 6985.3 7165.6 3285.0 3363.6 3401.8 3412.9 3483.5 2600.2 2675.4 2700.0 2700.3 2712.9 446.4 448.0 450.9 451.9 458.0 642.8 655.2 666.1 675.8 681.8 7869.8 8291.3 8355.2 8549.9 8889.4 623.2 640.8 662.2 662.9 666.8 3660.5 3738.5 3821.7 3895.2 3917.9 46086.0 49428.3 58385.7 60560.0 60661.7 52576.5 53520.5 54771.2 55290.7 55778.0 46829.8 47891.3 47936.8 48360.5 49485.0 7297.6 7413.4 7467.5 7479.4 7588.8 34119.5 34592.5 35092.3 35137.0 35506.5 38729.6 39479.2 39867.0 40889.4 41318.2 9178.6 9644.1 9652.4 9721.6 9744.9 8868.8 9010.6 9023.1 9095.6 9127.9 9302.6 9324.8 9404.8 9455.3 9856.6 9829.8 9926.2 10021.9 10328.8 10364.5 9641.1 9855.3 10037.9 10103.5 10379.3 8195.4 8533.8 8551.4 8561.6 8783.0 7788.0 7965.3 8039.3 8253.2 8417.7 09:12:25 INFO - PID 2919 | -------- Summary: end -------- 09:12:25 INFO - PID 2919 | 09:12:26 INFO - TEST-INFO | 2919: exit 0 09:12:26 INFO - TEST-OK | dromaeo_css | took 1121683ms 09:12:26 INFO - TEST-START | kraken 09:12:26 INFO - operating with platform_type : linux_ 09:12:26 INFO - Initialising browser for kraken test... 09:12:26 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm98GiS/profile http://localhost:49870/getInfo.html) 09:12:31 INFO - PID 3304 | __metrics Screen width/height:1600/1200 09:12:31 INFO - PID 3304 | colorDepth:24 09:12:31 INFO - PID 3304 | Browser inner width/height: 1024/697 09:12:31 INFO - PID 3304 | __metrics 09:12:32 ERROR - PID 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:12:33 INFO - TEST-INFO | 3304: exit 0 09:12:33 INFO - Browser initialized. 09:12:33 INFO - Running cycle 1/1 for kraken test... 09:12:33 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm98GiS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:45 INFO - PID 3434 | RSS: Main: 154976256 09:12:45 INFO - PID 3434 | 09:12:48 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49870/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:49 INFO - PID 3434 | RSS: Main: 160579584 09:12:49 INFO - PID 3434 | 09:12:51 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49870/tests/kraken/driver.html?testName=audio-dft) 09:12:52 INFO - PID 3434 | RSS: Main: 161017856 09:12:52 INFO - PID 3434 | 09:12:55 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49870/tests/kraken/driver.html?testName=audio-fft) 09:12:56 INFO - PID 3434 | RSS: Main: 157573120 09:12:56 INFO - PID 3434 | 09:12:58 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49870/tests/kraken/driver.html?testName=audio-oscillator) 09:12:58 INFO - PID 3434 | RSS: Main: 157970432 09:12:58 INFO - PID 3434 | 09:13:01 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:01 INFO - PID 3434 | RSS: Main: 158535680 09:13:01 INFO - PID 3434 | 09:13:04 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49870/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:05 INFO - PID 3434 | RSS: Main: 163651584 09:13:05 INFO - PID 3434 | 09:13:09 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49870/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:09 INFO - PID 3434 | RSS: Main: 161075200 09:13:09 INFO - PID 3434 | 09:13:12 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49870/tests/kraken/driver.html?testName=json-parse-financial) 09:13:13 INFO - PID 3434 | RSS: Main: 162136064 09:13:13 INFO - PID 3434 | 09:13:15 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:15 INFO - PID 3434 | RSS: Main: 162832384 09:13:15 INFO - PID 3434 | 09:13:17 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:18 INFO - PID 3434 | RSS: Main: 162729984 09:13:18 INFO - PID 3434 | 09:13:20 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:20 INFO - PID 3434 | RSS: Main: 163168256 09:13:20 INFO - PID 3434 | 09:13:23 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:24 INFO - PID 3434 | RSS: Main: 163577856 09:13:24 INFO - PID 3434 | 09:13:27 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:28 INFO - PID 3434 | RSS: Main: 163368960 09:13:28 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | Cycle 1(1): loaded http://localhost:49870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49870/tests/kraken/driver.html?testName=ai-astar) 09:13:30 INFO - PID 3434 | RSS: Main: 165093376 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | __start_tp_report 09:13:30 INFO - PID 3434 | _x_x_mozilla_page_load 09:13:30 INFO - PID 3434 | _x_x_mozilla_page_load_details 09:13:30 INFO - PID 3434 | |i|pagename|runs| 09:13:30 INFO - PID 3434 | |0;ai-astar;109;119;119;120;118;120;121;121;118;120 09:13:30 INFO - PID 3434 | |1;audio-beat-detection;157;127;126;186;128;128;128;133;147;127 09:13:30 INFO - PID 3434 | |2;audio-dft;166;164;168;171;169;167;164;167;163;165 09:13:30 INFO - PID 3434 | |3;audio-fft;76;76;76;113;77;76;76;75;100;75 09:13:30 INFO - PID 3434 | |4;audio-oscillator;85;85;117;85;84;85;105;85;85;109 09:13:30 INFO - PID 3434 | |5;imaging-gaussian-blur;115;115;114;115;114;118;114;114;114;114 09:13:30 INFO - PID 3434 | |6;imaging-darkroom;154;151;152;152;152;157;152;153;152;151 09:13:30 INFO - PID 3434 | |7;imaging-desaturate;94;95;95;94;94;94;95;96;94;94 09:13:30 INFO - PID 3434 | |8;json-parse-financial;69;70;72;68;70;71;69;71;70;70 09:13:30 INFO - PID 3434 | |9;json-stringify-tinderbox;56;56;59;56;56;56;56;57;56;56 09:13:30 INFO - PID 3434 | |10;stanford-crypto-aes;84;82;90;87;86;85;84;84;83;82 09:13:30 INFO - PID 3434 | |11;stanford-crypto-ccm;135;140;135;135;143;144;141;136;194;135 09:13:30 INFO - PID 3434 | |12;stanford-crypto-pbkdf2;185;192;198;191;182;190;197;197;189;195 09:13:30 INFO - PID 3434 | |13;stanford-crypto-sha256-iterative;72;74;73;72;71;71;70;71;70;71 09:13:30 INFO - PID 3434 | __end_tp_report 09:13:30 INFO - PID 3434 | __start_cc_report 09:13:30 INFO - PID 3434 | _x_x_mozilla_cycle_collect,887 09:13:30 INFO - PID 3434 | __end_cc_report 09:13:30 INFO - PID 3434 | __startTimestamp1489940010451__endTimestamp 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | ------- Summary: start ------- 09:13:30 INFO - PID 3434 | Number of tests: 14 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#0] ai-astar Cycles:10 Average:118.50 Median:120.00 stddev:3.50 (2.9%) stddev-sans-first:1.13 09:13:30 INFO - PID 3434 | Values: 109.0 119.0 119.0 120.0 118.0 120.0 121.0 121.0 118.0 120.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:130.50 stddev:19.58 (15.0%) stddev-sans-first:19.62 09:13:30 INFO - PID 3434 | Values: 157.0 127.0 126.0 186.0 128.0 128.0 128.0 133.0 147.0 127.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 09:13:30 INFO - PID 3434 | Values: 166.0 164.0 168.0 171.0 169.0 167.0 164.0 167.0 163.0 165.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.28 (17.5%) stddev-sans-first:13.91 09:13:30 INFO - PID 3434 | Values: 76.0 76.0 76.0 113.0 77.0 76.0 76.0 75.0 100.0 75.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:85.00 stddev:12.64 (14.9%) stddev-sans-first:13.11 09:13:30 INFO - PID 3434 | Values: 85.0 85.0 117.0 85.0 84.0 85.0 105.0 85.0 85.0 109.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.32 09:13:30 INFO - PID 3434 | Values: 115.0 115.0 114.0 115.0 114.0 118.0 114.0 114.0 114.0 114.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#6] imaging-darkroom Cycles:10 Average:152.60 Median:152.00 stddev:1.78 (1.2%) stddev-sans-first:1.81 09:13:30 INFO - PID 3434 | Values: 154.0 151.0 152.0 152.0 152.0 157.0 152.0 153.0 152.0 151.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:13:30 INFO - PID 3434 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 96.0 94.0 94.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:1.15 (1.6%) stddev-sans-first:1.17 09:13:30 INFO - PID 3434 | Values: 69.0 70.0 72.0 68.0 70.0 71.0 69.0 71.0 70.0 70.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 09:13:30 INFO - PID 3434 | Values: 56.0 56.0 59.0 56.0 56.0 56.0 56.0 57.0 56.0 56.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:2.45 (2.9%) stddev-sans-first:2.59 09:13:30 INFO - PID 3434 | Values: 84.0 82.0 90.0 87.0 86.0 85.0 84.0 84.0 83.0 82.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.50 stddev:17.99 (12.8%) stddev-sans-first:18.80 09:13:30 INFO - PID 3434 | Values: 135.0 140.0 135.0 135.0 143.0 144.0 141.0 136.0 194.0 135.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:193.50 stddev:5.34 (2.8%) stddev-sans-first:5.10 09:13:30 INFO - PID 3434 | Values: 185.0 192.0 198.0 191.0 182.0 190.0 197.0 197.0 189.0 195.0 09:13:30 INFO - PID 3434 | 09:13:30 INFO - PID 3434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 09:13:30 INFO - PID 3434 | Values: 72.0 74.0 73.0 72.0 71.0 71.0 70.0 71.0 70.0 71.0 09:13:30 INFO - PID 3434 | -------- Summary: end -------- 09:13:30 INFO - PID 3434 | 09:13:31 INFO - TEST-INFO | 3434: exit 0 09:13:31 INFO - TEST-OK | kraken | took 65386ms 09:13:31 INFO - SUITE-END | took 1187s 09:13:32 INFO - Completed test suite (00:19:47) 09:13:32 INFO - javascript benchmark 09:13:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6677.800608007305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.8534330611833, 2668.03950577792, 2681.852498112603, 2706.7969902257323, 2721.618973343731, 4922.261660750889, 4928.556429921311, 4966.10610090184, 4971.304017437553, 4999.500049994998, 4927.5072492750705, 4958.082754690376, 5022.447530771612, 5029.7988080476825, 5039.5716364109, 4199.202151591188, 4474.373587697725, 4518.593326600605, 4520.480144783359, 4635.860924172263, 4533.2066888294585, 4550.840720574781, 4592.954070459303, 4597.011642496863, 4601.838935637254, 4443.4445694288215, 4503.144402563503, 4512.052468981517, 4577.862664120048, 4601.401817763703, 4535.750533720644, 4535.841245556389, 4551.590356867865, 4595.770211489412, 4606.746628935407, 4487.730736155809, 4490.730556166608, 4509.7970591323465, 4510.548945105464, 4584.9541504585195, 4788.377510923592, 4848.781804818792, 4946.109700253953, 4957.0, 4989.501049895018, 5282.102042652758, 5293.708846013467, 5297.417284098746, 5318.787248510055, 5326.493983071602, 5317.680939143664, 5325.041492531343, 5329.493698098674, 5334.839954801362, 5372.811951581676, 4875.366202393737, 4939.678920870204, 4941.283513890466, 4941.925871111936, 4947.975260123676, 5290.788368465218, 5453.809116680976, 5500.642458240201, 5522.978249023863, 5558.194061861008, 5151.22731590257, 5221.55616772571, 5280.075986702312, 5282.128448805904, 5284.313039304942, 5285.0, 5319.813806516753, 5332.0, 5332.600054995891, 5338.91991620126, 5136.974315128476, 5155.845324640267, 5182.119039763249, 5280.498352656491, 5282.894342113136, 5289.497497737709, 5292.232626269247, 5292.994331077083, 5313.654612450178, 5330.706811125426, 4516.412866327357, 4527.1172121436, 4531.637469002472, 4531.682782205214, 4569.817207311737, 3861.7296789225047, 3876.8255428505786, 3912.0, 3921.9019524511546, 3928.253631809947, 4631.073785242897, 4652.209124448852, 4655.464621568563, 4676.041411510632, 4696.248600224016, 5326.733663316819, 5333.651285719951, 5348.652337598043, 5356.7321633918145, 5384.730763461811, 4528.660350473728, 4632.5830675239395, 4638.257878739386, 4641.071785642885, 4696.342512048316, 4705.976470117627, 4716.858494245178, 4717.858464246078, 4720.33915251865, 4730.455997560256, 4860.513948605111, 4891.584215341736, 4902.01959608087, 4903.779329930233, 4907.803687852446, 5222.9216561750845, 5269.420363759907, 5322.946770532245, 5324.0, 5324.653897496651, 4927.236278376858, 4952.306677065286, 4953.2074868020945, 4969.3291405659775, 4975.950240497548, 5157.690538567698, 5175.870603234949, 5184.377874655065, 5231.503007214308, 5235.476452354734, 5320.760565774627, 5355.785768569213, 5367.865803354791, 5390.110631745718, 5413.83758487246, 5139.331886854685, 5148.613853961043, 5161.948380516147, 5188.714620695898, 5189.273501709839, 5123.308353372247, 5157.690538567698, 5163.690178589297, 5175.9741201293755, 5189.506996835295, 4929.704217746947, 4996.0, 5090.4655011223285, 5107.8507335849135, 5120.436751957356, 5157.716325602128, 5162.09663308927, 5166.638335316492, 5185.040767458032, 5232.529072383504, 4985.451600324034, 4999.0251900878975, 5011.674241174312, 5022.422421421583, 5033.597312214941], "value": 4855.362814886008, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.4270270810331, 691.3397705191543, 711.4024219655488, 857.4126723194612, 870.0168809245552, 33965.83017084914, 34747.82626086869, 34835.12912177197, 34872.825635871784, 34882.30235395294, 30950.380992380196, 31305.373892522137, 31326.216844578896, 31423.214419639462, 31424.371512569734, 6328.430441260297, 6558.049082882979, 8913.910860891372, 9235.861462078074, 9254.352195346328, 9319.767005824875, 9382.202512786387, 9467.195288400495, 9476.952615236914, 9479.810403791955, 9436.716898493021, 9463.10100540451, 9496.762580935463, 9551.665691700791, 9556.856647150298, 9394.530273486333, 9439.575219115088, 9460.432374057544, 9464.905350946472, 9474.526273686288, 9195.862062069074, 9328.95335523318, 9334.113259240428, 9342.719718408458, 9355.532223388804, 34971.1257218569, 35310.82344588287, 35389.0, 35673.1081722959, 35801.64198358009, 3235.7573182011442, 3308.1894935740656, 3328.916777080568, 3338.6828251316088, 3382.9323413531592, 23446.296611101694, 23733.643995340084, 23847.92684329192, 24176.758232417626, 24614.630780538308, 3375.7299416046903, 3422.9486557701653, 3431.6396778338412, 3463.8960831175104, 3493.8951831444842, 156936.0, 157531.0, 158389.20805396014, 158438.0, 159123.0, 43056.56943430525, 43125.0, 43170.0, 43357.0, 43393.78303108464, 44727.55272447234, 45064.3240351395, 45140.0, 45168.548314517095, 45272.773636131606, 11898.702532436759, 12132.69668258283, 12161.695957600954, 12223.0, 12255.387230638433, 9577.329586928987, 9640.951795241119, 9655.420674759536, 9663.855042174373, 9668.196223095223, 13548.729025419634, 13564.253966031964, 13632.0, 13788.93105534466, 13885.0, 5571.303587051619, 5672.8865422691315, 5679.176519404746, 5726.398728133486, 5739.306904463193, 997.3716558568055, 1014.0518615094762, 1027.5941003303653, 1042.4475028235047, 1043.76515284062, 22533.661995070088, 22619.43451413728, 22683.659745103836, 22754.311422144463, 23058.76941230566, 1070.4754670211696, 1085.3596378136779, 1088.6244245735209, 1114.0641860836774, 1117.6032508459543, 11188.832167517494, 12079.57721479744, 12115.273083615011, 12179.756404871852, 12260.26438413698, 213111.0, 213968.0, 214026.0, 215390.0, 215745.0, 43572.0, 44199.558004420185, 44235.33646995298, 44346.33480497795, 44422.777886111006, 1093.10365500289, 1181.7931861924128, 1226.1723336747839, 1227.1042139238407, 1300.388817255907, 22103.44741381478, 24108.638370424105, 24737.257882263562, 24742.87628561846, 24807.379815504755, 29339.266518337212, 29543.0, 29568.704312956594, 29631.407371852874, 29903.252418689706, 170551.0, 170785.0, 171016.0, 171128.0, 171168.0, 27629.585556217076, 27649.585256221577, 27729.168124956283, 27845.44309113847, 27913.0, 32536.34927301488, 32736.0, 33000.834995824865, 33154.33691326208, 33486.497702534965, 29960.85019574888, 30605.0, 31897.202569935936, 31955.520667190474, 31966.68033319637, 30699.0, 30870.69129308768, 31182.68817311798, 31225.8438707805, 31827.522587161675, 29066.0, 29267.56098658479, 29653.25866853346, 30201.546976795806, 30530.84734576313, 24859.875700621382, 26096.478070438105, 27864.721352787023, 28576.428471430037, 28801.279968000967, 22286.331410057723, 22677.886610566842, 22734.886325568266, 22903.08387664475, 22928.656070159293], "value": 15642.006717270267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.78998815609987, 415.34583031725043, 419.45680343954575, 436.96285815705664, 437.9321205213191, 15681.0, 17747.201375938082, 18165.909170454128, 18207.453776386712, 18211.08944552772, 17002.0, 17240.655186896256, 17324.480265592054, 17376.131193440342, 17392.82607173928, 5240.528352448279, 5343.118385466403, 5470.206820011096, 5627.2684551008315, 5671.347795003566, 5535.169724541331, 5603.495685388314, 5618.943810561883, 5624.91562626561, 5639.520640745542, 5599.552035837123, 5602.971985140069, 5611.7474713637785, 5631.859203519924, 5643.661380317194, 5484.341878974528, 5652.98246315663, 5663.660180389169, 5665.1502274658715, 5670.404607516234, 5519.31008623922, 6260.0, 6529.869402611968, 6539.08452816606, 6559.917613593751, 21290.848284584514, 21634.78365216359, 21830.345089647337, 22178.556428871492, 22270.438899526598, 2277.7380601230907, 2282.646189840561, 2296.7588403217756, 2300.1029598456616, 2353.2822489140804, 12653.810192847115, 12823.935880320632, 13722.725545489035, 14127.15237085778, 14356.210408427532, 1852.5090850924516, 1931.5364312565023, 1952.4240349097051, 1952.4923519884933, 1957.3051566693762, 83702.58148709279, 84190.57904710498, 84326.0, 84372.57813710954, 86654.56672716659, 16116.75824862628, 16277.67444651124, 16365.83634163667, 16426.75359869603, 16504.33982640705, 27845.164645060682, 27914.441711165662, 28090.71909280922, 28143.0, 28170.19702340158, 8118.512889226666, 8252.504849708917, 8287.0, 8523.232909038215, 8582.82834343322, 6733.3939945405145, 6763.222229443677, 6900.2409734929115, 6959.582425054513, 7006.299370062953, 8699.652013919498, 8736.388452808242, 8855.51294678786, 8932.0, 9094.681686140953, 3334.216459132102, 3435.7766745161484, 3489.5114683944266, 3564.3821521156046, 3684.373656478405, 817.8200795824908, 844.7550210439027, 851.5614458553849, 861.0958493581714, 887.7603047177226, 17432.0, 17473.0, 18389.264429422674, 18611.441656750318, 20149.597008059758, 847.9745607631781, 859.9484030958163, 861.1044513705801, 873.6287077991828, 890.3144578674514, 6374.776882809079, 6536.150300461005, 6547.410733034049, 6605.834854128685, 6772.085768421299, 488794.0, 490643.0, 493865.0, 497174.0, 503072.0, 85801.0, 85946.0, 86871.56564217138, 87260.5636971811, 89419.0, 1077.6012875236213, 1101.4657890922897, 1145.7364806094479, 1146.1232157399595, 1150.2121047082776, 16138.0, 16400.0, 17034.126246113166, 17085.402010929556, 17322.48032558975, 37701.62298377091, 38593.42109868298, 42023.7898810504, 42883.35674964941, 43716.34425483557, 55167.72416137894, 56145.0, 56293.43706562882, 56395.0, 56796.14805777834, 10659.626913058006, 10683.450899619667, 10689.625863094754, 10847.566097356017, 11281.153913456688, 12128.696782580506, 12534.373281336078, 12540.247585144556, 12607.873921261036, 12741.617751467471, 10680.679579612624, 10686.145108391465, 11087.944560277147, 11233.48347973046, 11235.943820280847, 10150.238732094975, 10519.26365154432, 10539.26225164231, 10616.522256498321, 10884.61903833362, 10526.421036844535, 10728.785424291627, 10790.946045269724, 10888.891111089104, 11281.71795705081, 10636.30863993838, 10721.249512534048, 10902.40036797952, 10923.180761442765, 11269.436528173395, 10534.315269507457, 10695.625653102104, 10828.5127169276, 10925.289856159325, 10983.286086404358], "value": 9610.341197092474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.2386247220202, 1474.5502621700384, 1485.5394827603436, 1502.0311898825257, 1562.1720488141286, 7784.299413052824, 8086.878696819553, 8902.732918012462, 9288.4426934384, 9311.580978855942, 9180.8622870657, 9487.525623718804, 9493.382930109537, 9504.0, 9543.0, 2059.1454546363243, 2112.4613223627953, 2114.4608124928122, 2115.936521904345, 2115.957680846382, 1968.1045124468403, 1975.87156834806, 1986.73179120819, 1996.161612122912, 2007.8895660738654, 2015.707722380254, 2018.0716870239708, 2032.2683833819813, 2033.0343087033689, 2033.7356143701297, 1926.1236137557378, 1933.468296218537, 1933.7389452423884, 1934.5453818352676, 1937.4671965209538, 1942.786293507713, 1987.2647120565339, 2005.2380095563738, 2013.9194432222694, 2025.6151331247015, 9707.466089365082, 9729.318947673666, 9778.462184579845, 9782.461964591945, 9787.021297870227, 4578.427696537933, 4696.483386827446, 4770.998090400985, 4771.260454629538, 4786.282057691339, 2494.7006359237007, 2598.6751656042993, 2658.2689760315875, 2729.0993971989396, 2729.372244383803, 947.9194268487187, 993.3692105512979, 1013.6300250408548, 1020.4693559349097, 1022.0545994954712, 14342.856571434257, 14427.567172984827, 14442.422303107864, 14472.348744306531, 14481.493147739779, 3960.4653371795016, 4090.4886889138857, 4170.645495132948, 4194.916101677949, 4314.848980285675, 11821.940890295493, 11848.170628055954, 11893.821592676117, 11921.463534140985, 11938.940305298418, 4977.0, 4986.950130498649, 4990.5508504234795, 4999.950000499948, 5011.699298042129, 3614.331348700499, 3844.38489841624, 4229.577042295808, 4326.437563116838, 4457.710248833815, 3471.704905083096, 3495.475678648223, 3497.8107443469344, 3522.365974124682, 3574.3208790329754, 1004.1314263162312, 1004.3622299839654, 1005.2661557063385, 1020.1430798129607, 1023.2734758321526, 844.7676888855491, 853.9274161696201, 859.7034023261965, 878.424631866116, 884.9557522123868, 5478.753456094485, 5623.0, 5661.547076233891, 5753.108268218432, 5897.823065308047, 889.2619126125301, 902.6267732834407, 903.1375036839802, 906.9047749986288, 919.5815903763771, 3492.2840817632323, 3503.2818272254126, 3569.089882080053, 3716.349638813197, 3977.980110099431, 11574.537018519333, 11851.288922664495, 12083.818742718866, 12259.141860069709, 12285.140040197279, 12125.939370303093, 12150.33173175466, 12171.896166477492, 12196.939015305044, 12210.511579536897, 8434.409591328671, 8485.0666426693, 8810.339224558184, 8824.77938051541, 8831.0, 5678.290213723285, 5792.797252096157, 5840.620359676607, 5967.134765458897, 6013.067974463965, 10907.563697452331, 10908.290961087503, 10926.890731092906, 11004.779904402027, 11029.283096598696, 10371.0, 10524.684259472227, 10528.683689588279, 10671.413072280788, 10715.35707857531, 6565.704543295467, 6777.322267773183, 7677.654505547152, 7745.496542724705, 7971.601419929097, 9085.182333590008, 9194.218491428304, 9207.355485116246, 9217.170454658844, 9231.307651926267, 7585.6965721370525, 7619.1999840016, 7846.882296765667, 7880.3301719354495, 8024.438289319692, 7884.21157884207, 7983.560904150328, 8118.797030074295, 8143.79640508992, 8231.917680823115, 7183.928160718535, 7196.4962452627815, 7220.602866842374, 7260.564366138048, 7296.854062918818, 5246.160614301693, 5300.814471493633, 5363.141897296414, 5407.86480337979, 5440.483154100354, 4860.8298709545, 4962.5533701967, 5020.949790502048, 5249.580033597226, 5306.8938621228135], "value": 4486.242143045555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7472118959108, 391.2507548045493, 392.61327592321567, 402.3481959226052, 402.50692901196055, 5189.948100518994, 5369.09397164007, 5420.349558053029, 5491.780328786854, 5492.972535137329, 5168.689878607286, 5331.2003199520095, 5373.596980226479, 5387.946120538793, 5393.298871146755, 4644.210484217691, 4648.9767551162195, 4658.9068218635775, 4663.27719203524, 4676.415448068991, 4564.475085365176, 4611.746353950532, 4625.398698169233, 4650.930236046462, 4658.604018658418, 4605.8024913522395, 4606.884827879297, 4607.953920460803, 4624.768761561909, 4625.167469855424, 4596.494385617613, 4608.3778689876945, 4625.236835922069, 4636.884077898063, 4659.534046595347, 4387.517373088957, 4408.693479890082, 4420.491643461011, 4477.955220447787, 4482.260427029536, 5204.817831375922, 5240.0, 5250.369955605313, 5251.396089449724, 5284.788608455658, 5407.432219616962, 5438.782448702047, 5438.8912221755345, 5439.47064614956, 5448.645838020516, 5581.5813813963705, 5658.91511627326, 5708.857278568027, 5720.856978575569, 5761.971190144064, 4860.756962151913, 4872.488388719169, 4905.558499735005, 4910.263460480921, 4915.606751459874, 5759.769609215627, 5796.710164491758, 5932.614380065282, 6031.52707389968, 6082.343420618823, 5021.171506701427, 5125.282460455539, 5127.6154288428515, 5128.333316668809, 5136.229565565195, 5245.527902488794, 5245.842624721265, 5251.816186433456, 5258.290130832289, 5258.894822103536, 5309.787608495617, 5378.489043540857, 5383.838484845461, 5409.161579955114, 5436.891262174734, 5685.857853553612, 5689.886202276014, 5708.715539003774, 5710.37185909558, 5714.114312281603, 1579.8499142581436, 1816.7638207033, 1846.6150387209593, 1850.2691436882626, 1851.2039822876293, 1226.1233218248994, 1234.7098431868503, 1261.2621616354536, 1275.3113318807925, 1280.711839836048, 4910.238912968495, 4919.794650310625, 4932.67937584063, 4939.283803848493, 4949.0, 5802.1296805479515, 5805.274340707411, 5809.2738407699035, 5813.767449302065, 5813.912791308134, 4683.0, 4929.556339929423, 4935.531124543163, 4950.876228094255, 4955.0, 3074.6003019607756, 3098.0, 3107.285324375406, 3112.517559778238, 3113.4395808754643, 5406.135018397116, 5438.3473983121485, 5442.455754424605, 5443.346798384219, 5456.706994215605, 5685.488306052475, 5950.67271300074, 5965.13505541694, 5986.6707331097205, 5995.700214989233, 5405.540529054996, 5412.5940554458575, 5412.972935135378, 5419.566434685295, 5432.701201433959, 5613.803516876889, 5778.971105144447, 5798.449147330997, 5823.475887170175, 5833.191710569737, 5492.697901615449, 5664.518515926193, 5761.48146666802, 5804.736152900457, 5818.9525885341045, 5325.97337013328, 5477.20580515831, 5489.972550137224, 5498.697571633598, 5504.4495550444635, 4656.8602941911795, 4683.976580117078, 4695.600873925755, 4708.529147085264, 4711.222648263135, 5777.3933736957015, 5849.1226316052935, 5866.208061911588, 5873.119032145212, 5894.705264736832, 5656.943430565641, 5669.886602267849, 5672.808710170911, 5681.0910254359105, 5685.20407142992, 5481.588880834033, 5681.0910254359105, 5700.686462244616, 5720.599558030898, 5731.111677689964, 5545.500904918576, 5589.9379117967455, 5590.161475778666, 5598.748056337393, 5611.354694210218, 5703.144528320785, 5726.484616384545, 5738.913916291175, 5745.396733343106, 5747.166660834239, 5397.406285308692, 5505.917411238915, 5544.889102218014, 5562.527185189142, 5591.217229587943], "value": 4532.450010924683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.5608218165103, 629.9811005669832, 665.9633720145393, 674.8076798112537, 682.5666498931313, 12434.25394476331, 12556.874431255696, 12601.495940162395, 13620.591382258523, 14265.072770269951, 12450.750984980317, 12607.558735444261, 12614.684632884182, 12622.558210462636, 12626.873731262707, 817.9345652347813, 840.0591337701783, 841.9915800842005, 842.8314337132598, 844.2401838345477, 810.027966440274, 835.4068611285994, 845.6110189312924, 846.4751853850621, 853.3812985585463, 872.9825403491926, 873.598144853365, 878.3939082033409, 880.6697488441835, 882.2897567458193, 873.6985739919718, 875.369733791669, 878.0911756332198, 880.9603567839431, 889.0131953531575, 647.423792824382, 647.4949539359308, 647.773279352223, 651.8891788395985, 652.9379708927644, 13943.16341019542, 14286.71426571473, 14298.356573954197, 14302.71394572113, 14725.852741472663, 13338.333083345793, 13834.0, 13935.721285574231, 13972.580822575339, 13988.860111398857, 9325.673601423985, 10313.226508011929, 10380.584776608926, 10403.427811470367, 10433.269671123024, 3180.6024246969127, 3204.83975801209, 3208.4385232584436, 3235.0, 3246.1559994401628, 35431.822840885885, 37903.81048094769, 46092.53907460916, 48844.75577622089, 49852.0, 10867.40229287381, 11169.0, 11268.718282043015, 11400.087992960709, 11546.59586914454, 21373.67939480909, 21445.0, 21568.784312156993, 21698.78301216999, 21929.23247686323, 6800.387965083166, 6894.724211031503, 6934.16789985205, 6985.26654701249, 7165.593160206436, 3284.9671503284662, 3363.646817084171, 3401.795892246473, 3412.931741365159, 3483.54713887193, 2600.1939398786435, 2675.3712877473777, 2699.973000269972, 2700.338417087826, 2712.891484340604, 446.3973635591925, 447.9888002799956, 450.8692479181066, 451.9231730605805, 458.01298202373937, 642.7782415066795, 655.2039272284197, 666.1107421592228, 675.8411773233287, 681.8363592737807, 7869.842603148019, 8291.253787159185, 8355.164483551596, 8549.914500854911, 8889.377743558018, 623.183629445428, 640.8365866703961, 662.215274899246, 662.8641128568631, 666.8499587592753, 3660.524131862894, 3738.457923601117, 3821.6751576115785, 3895.1820117775583, 3917.882463526099, 46086.0, 49428.258576121385, 58385.70807146022, 60560.0, 60661.69669151714, 52576.47423525792, 53520.46479535232, 54771.17843232355, 55290.72354638201, 55778.0, 46829.76585117121, 47891.28163077487, 47936.7603161982, 48360.516394836304, 49485.0, 7297.562146271241, 7413.406927445899, 7467.477276590804, 7479.401647868049, 7588.81027974305, 34119.4882076774, 34592.48111278383, 35092.298154037286, 35137.0, 35506.467402989496, 38729.6127038726, 39479.2104157921, 39867.0, 40889.38665919954, 41318.1736365265, 9178.586963586522, 9644.083812037845, 9652.372595781251, 9721.562529686322, 9744.902550974683, 8868.778280543038, 9010.594523246338, 9023.097690230925, 9095.636174552943, 9127.863082053642, 9302.581383837609, 9324.766880828034, 9404.764880878032, 9455.338126331091, 9856.605735770776, 9829.803403931739, 9926.15627671656, 10021.899781002097, 10328.845067324146, 10364.481775911325, 9641.079904767088, 9855.31012829095, 10037.949810250902, 10103.545340459845, 10379.325343852626, 8195.426320157532, 8533.786655333419, 8551.35864810154, 8561.57192140378, 8782.956085219534, 7787.961060194662, 7965.283124518821, 8039.276465118168, 8253.215944485264, 8417.663293468438], "value": 5974.402707567526, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 119.0, 119.0, 120.0, 118.0, 120.0, 121.0, 121.0, 118.0, 120.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 126.0, 186.0, 128.0, 128.0, 128.0, 133.0, 147.0, 127.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 168.0, 171.0, 169.0, 167.0, 164.0, 167.0, 163.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 113.0, 77.0, 76.0, 76.0, 75.0, 100.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 84.0, 85.0, 105.0, 85.0, 85.0, 109.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 115.0, 114.0, 118.0, 114.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 152.0, 152.0, 152.0, 157.0, 152.0, 153.0, 152.0, 151.0], "value": 152.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 68.0, 70.0, 71.0, 69.0, 71.0, 70.0, 70.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 90.0, 87.0, 86.0, 85.0, 84.0, 84.0, 83.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 135.0, 135.0, 143.0, 144.0, 141.0, 136.0, 194.0, 135.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 192.0, 198.0, 191.0, 182.0, 190.0, 197.0, 197.0, 189.0, 195.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 72.0, 71.0, 71.0, 70.0, 71.0, 70.0, 71.0], "value": 71.5, "unit": "score"}]}]} 09:13:32 INFO - Return code: 0 09:13:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:32 ERROR - # TBPL SUCCESS # 09:13:32 INFO - Running post-action listener: _resource_record_post_action 09:13:32 INFO - [mozharness: 2017-03-19 16:13:32.283436Z] Finished run-tests step (success) 09:13:32 INFO - Running post-run listener: _resource_record_post_run 09:13:32 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 361717760; Read time: 0; Write time: 331588 09:13:32 INFO - TinderboxPrint: CPU usage
13.3% 09:13:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:13:32 INFO - TinderboxPrint: I/O write bytes / time
361,717,760 / 331,588 09:13:32 INFO - TinderboxPrint: CPU idle
8,318.2 (86.6%) 09:13:32 INFO - TinderboxPrint: CPU user
1,222.2 (12.7%) 09:13:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105091072; Read time: 0; Write time: 98472 09:13:32 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 256184320; Read time: 0; Write time: 233092 09:13:32 INFO - Running post-run listener: _upload_blobber_files 09:13:32 INFO - Blob upload gear active. 09:13:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:13:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:34 INFO - (blobuploader) - INFO - Done attempting. 09:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:35 INFO - (blobuploader) - INFO - Done attempting. 09:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:36 INFO - (blobuploader) - INFO - Done attempting. 09:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:39 INFO - (blobuploader) - INFO - Done attempting. 09:13:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:39 INFO - Return code: 0 09:13:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6c3909f7f93f2a30dacdbc07d26f73aabb458cd3662f8dd4f8f87331b9a4ba63b3825a2c00ce82e13214c809c779e51c9e61a150ab49ca2a179e7e54ebde5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec61bdbb54339f60d8cdf11a8099e8baeedc833514087b64980cb659a6998eced72b87a2a928b9f60ab0a80a660f3305850f4f5e38ab9b2067432709f6a2a52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc65e56d38c0b21ca2661f339f3781c947ccbab34d171f69c13487b9e8e15250f124b2b54b9b41a94f29e2d40d25a04c848b89c9a7ce83acf67d99f81565495a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06fbaf1247b11dc3d76a10690b2bedf637499e06c62638f200a1d4c5c256d3b84e371146913261e89bc037fdf9c7ca985a4bade74f44d743ab696e55b1aa68f8"} 09:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:39 INFO - Contents: 09:13:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6c3909f7f93f2a30dacdbc07d26f73aabb458cd3662f8dd4f8f87331b9a4ba63b3825a2c00ce82e13214c809c779e51c9e61a150ab49ca2a179e7e54ebde5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec61bdbb54339f60d8cdf11a8099e8baeedc833514087b64980cb659a6998eced72b87a2a928b9f60ab0a80a660f3305850f4f5e38ab9b2067432709f6a2a52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc65e56d38c0b21ca2661f339f3781c947ccbab34d171f69c13487b9e8e15250f124b2b54b9b41a94f29e2d40d25a04c848b89c9a7ce83acf67d99f81565495a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06fbaf1247b11dc3d76a10690b2bedf637499e06c62638f200a1d4c5c256d3b84e371146913261e89bc037fdf9c7ca985a4bade74f44d743ab696e55b1aa68f8"} 09:13:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:39 INFO - Copying logs to upload dir... 09:13:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.225664 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-19 09:13:36.563621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:13:36.567741) ========= 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=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6c3909f7f93f2a30dacdbc07d26f73aabb458cd3662f8dd4f8f87331b9a4ba63b3825a2c00ce82e13214c809c779e51c9e61a150ab49ca2a179e7e54ebde5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec61bdbb54339f60d8cdf11a8099e8baeedc833514087b64980cb659a6998eced72b87a2a928b9f60ab0a80a660f3305850f4f5e38ab9b2067432709f6a2a52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc65e56d38c0b21ca2661f339f3781c947ccbab34d171f69c13487b9e8e15250f124b2b54b9b41a94f29e2d40d25a04c848b89c9a7ce83acf67d99f81565495a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06fbaf1247b11dc3d76a10690b2bedf637499e06c62638f200a1d4c5c256d3b84e371146913261e89bc037fdf9c7ca985a4bade74f44d743ab696e55b1aa68f8"} build_url:https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/RZ-lBF4NR0GtKKVznm2DDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6c3909f7f93f2a30dacdbc07d26f73aabb458cd3662f8dd4f8f87331b9a4ba63b3825a2c00ce82e13214c809c779e51c9e61a150ab49ca2a179e7e54ebde5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec61bdbb54339f60d8cdf11a8099e8baeedc833514087b64980cb659a6998eced72b87a2a928b9f60ab0a80a660f3305850f4f5e38ab9b2067432709f6a2a52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc65e56d38c0b21ca2661f339f3781c947ccbab34d171f69c13487b9e8e15250f124b2b54b9b41a94f29e2d40d25a04c848b89c9a7ce83acf67d99f81565495a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06fbaf1247b11dc3d76a10690b2bedf637499e06c62638f200a1d4c5c256d3b84e371146913261e89bc037fdf9c7ca985a4bade74f44d743ab696e55b1aa68f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-19 09:13:36.592744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:13:36.593071) ========= 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=781b77c4c33858b1f599d705000001c1-1489933629.400946-1799888255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-19 09:13:36.676881) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:13:36.677329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-19 09:13:36.677790) ========= ========= Total master_lag: 0.14 =========