builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1465124537.68 results: success (0) buildid: 20160605010644 builduid: a6b3154f0b2c4bd0ae1605cb13f7ab02 revision: 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.681238) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.681628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.689469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.714891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.715175) ========= 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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 04:02:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-06-05 04:02:19 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.894568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.894887) ========= 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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019243 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.944473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:17.944854) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 --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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 04:02:19,133 truncating revision to first 12 chars 2016-06-05 04:02:19,133 Setting DEBUG logging. 2016-06-05 04:02:19,133 attempt 1/10 2016-06-05 04:02:19,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/072ce9419eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 04:02:19,460 unpacking tar archive at: mozilla-aurora-072ce9419eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:18.620515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:18.620827) ========= script_repo_revision: 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:18.621217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:18.621558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:02:18.632212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-05 04:02:18.632518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:19 INFO - MultiFileLogger online at 20160605 04:02:19 in /builds/slave/test 04:02:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:02:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:19 INFO - {'append_to_log': False, 04:02:19 INFO - 'base_work_dir': '/builds/slave/test', 04:02:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:02:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:19 INFO - 'branch': 'Mozilla-Aurora', 04:02:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:19 INFO - 'config_files': ('talos/linux_config.py',), 04:02:19 INFO - 'default_actions': ('clobber', 04:02:19 INFO - 'read-buildbot-config', 04:02:19 INFO - 'download-and-extract', 04:02:19 INFO - 'populate-webroot', 04:02:19 INFO - 'create-virtualenv', 04:02:19 INFO - 'install', 04:02:19 INFO - 'run-tests'), 04:02:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:19 INFO - 'download_minidump_stackwalk': True, 04:02:19 INFO - 'download_symbols': 'ondemand', 04:02:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:19 INFO - 'installer_path': 'installer.exe', 04:02:19 INFO - 'log_level': 'info', 04:02:19 INFO - 'log_name': 'talos', 04:02:19 INFO - 'log_to_console': True, 04:02:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:19 INFO - 'opt_config_files': (), 04:02:19 INFO - 'pip_index': False, 04:02:19 INFO - 'sps_profile': False, 04:02:19 INFO - 'sps_profile_interval': 0, 04:02:19 INFO - 'suite': 'dromaeojs-e10s', 04:02:19 INFO - 'system_bits': '32', 04:02:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:19 INFO - 'title': 'talos-linux64-ix-044', 04:02:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:19 INFO - 'use_talos_json': True, 04:02:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:19 INFO - 'work_dir': 'build'} 04:02:19 INFO - ##### 04:02:19 INFO - ##### Running clobber step. 04:02:19 INFO - ##### 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: clobber 04:02:19 INFO - rmtree: /builds/slave/test/build 04:02:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:20 INFO - Running post-action listener: _resource_record_post_action 04:02:20 INFO - ##### 04:02:20 INFO - ##### Running read-buildbot-config step. 04:02:20 INFO - ##### 04:02:20 INFO - Running pre-action listener: _resource_record_pre_action 04:02:20 INFO - Running main action method: read_buildbot_config 04:02:20 INFO - Using buildbot properties: 04:02:20 INFO - { 04:02:20 INFO - "project": "", 04:02:20 INFO - "product": "firefox", 04:02:20 INFO - "script_repo_revision": "production", 04:02:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:02:20 INFO - "repository": "", 04:02:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:02:20 INFO - "buildid": "20160605010644", 04:02:20 INFO - "pgo_build": "True", 04:02:20 INFO - "basedir": "/builds/slave/test", 04:02:20 INFO - "buildnumber": 332, 04:02:20 INFO - "slavename": "talos-linux64-ix-044", 04:02:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:02:20 INFO - "platform": "ubuntu64_hw", 04:02:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:02:20 INFO - "branch": "mozilla-aurora", 04:02:20 INFO - "repo_path": "releases/mozilla-aurora", 04:02:20 INFO - "revision": "072ce9419eaaf6be1cdbd589176feec2b7d8ec07", 04:02:20 INFO - "stage_platform": "linux64-pgo", 04:02:20 INFO - "builduid": "a6b3154f0b2c4bd0ae1605cb13f7ab02", 04:02:20 INFO - "slavebuilddir": "test" 04:02:20 INFO - } 04:02:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:02:20 INFO - Running post-action listener: _resource_record_post_action 04:02:20 INFO - ##### 04:02:20 INFO - ##### Running download-and-extract step. 04:02:20 INFO - ##### 04:02:20 INFO - Running pre-action listener: _resource_record_pre_action 04:02:20 INFO - Running main action method: download_and_extract 04:02:20 INFO - mkdir: /builds/slave/test/build/tests 04:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:20 INFO - https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:02:22 INFO - Downloaded 1361 bytes. 04:02:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:02:22 INFO - Using the following test package requirements: 04:02:22 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:02:22 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:22 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:02:22 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'jsshell-linux-x86_64.zip'], 04:02:22 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:22 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:02:22 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:02:22 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:02:22 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:22 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:02:22 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:22 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:22 INFO - https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:23 INFO - Downloaded 24176672 bytes. 04:02:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:24 INFO - Return code: 0 04:02:24 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:24 INFO - https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:26 INFO - Downloaded 24176672 bytes. 04:02:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:27 INFO - Return code: 0 04:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:27 INFO - https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:02:28 INFO - Downloaded 10840145 bytes. 04:02:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:02:28 INFO - Return code: 0 04:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:28 INFO - https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:02:30 INFO - Downloaded 62796874 bytes. 04:02:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:02:30 INFO - mkdir: /builds/slave/test/properties 04:02:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:30 INFO - Contents: 04:02:30 INFO - build_url:https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:02:31 INFO - Running post-action listener: _resource_record_post_action 04:02:31 INFO - Running post-action listener: set_extra_try_arguments 04:02:31 INFO - ##### 04:02:31 INFO - ##### Running populate-webroot step. 04:02:31 INFO - ##### 04:02:31 INFO - Running pre-action listener: _resource_record_pre_action 04:02:31 INFO - Running main action method: populate_webroot 04:02:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:31 INFO - '--tppagecycles', 04:02:31 INFO - '7'], 04:02:31 INFO - 'tests': ['tsvgm']}}, 04:02:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['damp', 'tps']}, 04:02:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'tests': ['damp', 'tps']}, 04:02:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['dromaeo_dom']}, 04:02:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['a11yr', 04:02:31 INFO - 'ts_paint', 04:02:31 INFO - 'tpaint', 04:02:31 INFO - 'sessionrestore', 04:02:31 INFO - 'sessionrestore_no_auto_restore', 04:02:31 INFO - 'tabpaint']}, 04:02:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['tsvgx', 04:02:31 INFO - 'tsvgr_opacity', 04:02:31 INFO - 'tart', 04:02:31 INFO - 'tscrollx', 04:02:31 INFO - 'cart']}, 04:02:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:31 INFO - 'tsvgr_opacity', 04:02:31 INFO - 'tart', 04:02:31 INFO - 'tscrollx', 04:02:31 INFO - 'cart']}, 04:02:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'talos_options': ['--disable-e10s'], 04:02:31 INFO - 'tests': ['tp5o']}, 04:02:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'tests': ['tp5o']}, 04:02:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'talos_options': ['--disable-e10s', 04:02:31 INFO - '--xperf_path', 04:02:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:31 INFO - 'tests': ['tp5n']}, 04:02:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:31 INFO - 'talos_options': ['--xperf_path', 04:02:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:31 INFO - 'tests': ['tp5n']}}, 04:02:31 INFO - 'talos.zip': {'path': '', 04:02:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:31 INFO - Running post-action listener: _resource_record_post_action 04:02:31 INFO - ##### 04:02:31 INFO - ##### Running create-virtualenv step. 04:02:31 INFO - ##### 04:02:31 INFO - Running pre-action listener: _resource_record_pre_action 04:02:31 INFO - Running main action method: create_virtualenv 04:02:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:31 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 04:02:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:31 INFO - Using real prefix '/usr' 04:02:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:34 INFO - Installing pip.................done. 04:02:34 INFO - Return code: 0 04:02:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 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 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:34 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 04:02:34 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 04:02:34 INFO - Using env: {'DISPLAY': ':0', 04:02:34 INFO - 'HOME': '/home/cltbld', 04:02:34 INFO - 'LANG': 'en_US.UTF-8', 04:02:34 INFO - 'LANGUAGE': 'en_US:en', 04:02:34 INFO - 'LOGNAME': 'cltbld', 04:02:34 INFO - 'MAIL': '/var/mail/cltbld', 04:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:34 INFO - 'MOZ_NO_REMOTE': '1', 04:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:34 INFO - 'NO_EM_RESTART': '1', 04:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:34 INFO - 'PWD': '/builds/slave/test', 04:02:34 INFO - 'SHELL': '/bin/bash', 04:02:34 INFO - 'SHLVL': '1', 04:02:34 INFO - 'TERM': 'linux', 04:02:34 INFO - 'TMOUT': '86400', 04:02:34 INFO - 'USER': 'cltbld', 04:02:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:34 INFO - '_': '/tools/buildbot/bin/python'} 04:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:34 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 04:02:34 INFO - Cleaning up... 04:02:34 INFO - Return code: 0 04:02:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:34 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>=0.7.1'] in /builds/slave/test/build 04:02:34 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>=0.7.1 04:02:34 INFO - Using env: {'DISPLAY': ':0', 04:02:34 INFO - 'HOME': '/home/cltbld', 04:02:34 INFO - 'LANG': 'en_US.UTF-8', 04:02:34 INFO - 'LANGUAGE': 'en_US:en', 04:02:34 INFO - 'LOGNAME': 'cltbld', 04:02:34 INFO - 'MAIL': '/var/mail/cltbld', 04:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:34 INFO - 'MOZ_NO_REMOTE': '1', 04:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:34 INFO - 'NO_EM_RESTART': '1', 04:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:34 INFO - 'PWD': '/builds/slave/test', 04:02:34 INFO - 'SHELL': '/bin/bash', 04:02:34 INFO - 'SHLVL': '1', 04:02:34 INFO - 'TERM': 'linux', 04:02:34 INFO - 'TMOUT': '86400', 04:02:34 INFO - 'USER': 'cltbld', 04:02:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:34 INFO - '_': '/tools/buildbot/bin/python'} 04:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:34 INFO - Downloading/unpacking psutil>=0.7.1 04:02:34 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 04:02:34 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 04:02:34 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 04:02:34 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 04:02:34 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 04:02:34 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 04:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:36 INFO - Installing collected packages: psutil 04:02:36 INFO - Running setup.py install for psutil 04:02:36 INFO - building 'psutil._psutil_linux' extension 04:02:36 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 04:02:37 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 04:02:37 INFO - building 'psutil._psutil_posix' extension 04:02:37 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 04:02:37 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 04:02:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:37 INFO - Successfully installed psutil 04:02:37 INFO - Cleaning up... 04:02:37 INFO - Return code: 0 04:02:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:37 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:37 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.0.0'] in /builds/slave/test/build 04:02:37 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.0.0 04:02:37 INFO - Using env: {'DISPLAY': ':0', 04:02:37 INFO - 'HOME': '/home/cltbld', 04:02:37 INFO - 'LANG': 'en_US.UTF-8', 04:02:37 INFO - 'LANGUAGE': 'en_US:en', 04:02:37 INFO - 'LOGNAME': 'cltbld', 04:02:37 INFO - 'MAIL': '/var/mail/cltbld', 04:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:37 INFO - 'MOZ_NO_REMOTE': '1', 04:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:37 INFO - 'NO_EM_RESTART': '1', 04:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:37 INFO - 'PWD': '/builds/slave/test', 04:02:37 INFO - 'SHELL': '/bin/bash', 04:02:37 INFO - 'SHLVL': '1', 04:02:37 INFO - 'TERM': 'linux', 04:02:37 INFO - 'TMOUT': '86400', 04:02:37 INFO - 'USER': 'cltbld', 04:02:37 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:37 INFO - '_': '/tools/buildbot/bin/python'} 04:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:02:37 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 04:02:37 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 04:02:37 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 04:02:37 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 04:02:37 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 04:02:37 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 04:02:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:02:39 INFO - Installing collected packages: mozsystemmonitor 04:02:39 INFO - Running setup.py install for mozsystemmonitor 04:02:39 INFO - Successfully installed mozsystemmonitor 04:02:39 INFO - Cleaning up... 04:02:39 INFO - Return code: 0 04:02:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:39 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 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:39 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 04:02:39 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 04:02:39 INFO - Using env: {'DISPLAY': ':0', 04:02:39 INFO - 'HOME': '/home/cltbld', 04:02:39 INFO - 'LANG': 'en_US.UTF-8', 04:02:39 INFO - 'LANGUAGE': 'en_US:en', 04:02:39 INFO - 'LOGNAME': 'cltbld', 04:02:39 INFO - 'MAIL': '/var/mail/cltbld', 04:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:39 INFO - 'MOZ_NO_REMOTE': '1', 04:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:39 INFO - 'NO_EM_RESTART': '1', 04:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:39 INFO - 'PWD': '/builds/slave/test', 04:02:39 INFO - 'SHELL': '/bin/bash', 04:02:39 INFO - 'SHLVL': '1', 04:02:39 INFO - 'TERM': 'linux', 04:02:39 INFO - 'TMOUT': '86400', 04:02:39 INFO - 'USER': 'cltbld', 04:02:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:39 INFO - '_': '/tools/buildbot/bin/python'} 04:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:39 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 04:02:39 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 04:02:39 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 04:02:39 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 04:02:39 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 04:02:39 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 04:02:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:42 INFO - Downloading docopt-0.6.1.tar.gz 04:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:42 INFO - Running setup.py install for blobuploader 04:02:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:42 INFO - Running setup.py install for requests 04:02:42 INFO - Running setup.py install for docopt 04:02:43 INFO - Successfully installed blobuploader requests docopt 04:02:43 INFO - Cleaning up... 04:02:43 INFO - Return code: 0 04:02:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:43 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 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:43 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 04:02:43 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 04:02:43 INFO - Using env: {'DISPLAY': ':0', 04:02:43 INFO - 'HOME': '/home/cltbld', 04:02:43 INFO - 'LANG': 'en_US.UTF-8', 04:02:43 INFO - 'LANGUAGE': 'en_US:en', 04:02:43 INFO - 'LOGNAME': 'cltbld', 04:02:43 INFO - 'MAIL': '/var/mail/cltbld', 04:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:43 INFO - 'MOZ_NO_REMOTE': '1', 04:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:43 INFO - 'NO_EM_RESTART': '1', 04:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:43 INFO - 'PWD': '/builds/slave/test', 04:02:43 INFO - 'SHELL': '/bin/bash', 04:02:43 INFO - 'SHLVL': '1', 04:02:43 INFO - 'TERM': 'linux', 04:02:43 INFO - 'TMOUT': '86400', 04:02:43 INFO - 'USER': 'cltbld', 04:02:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:43 INFO - '_': '/tools/buildbot/bin/python'} 04:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:43 INFO - Running setup.py (path:/tmp/pip-Sd_EKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:43 INFO - Running setup.py (path:/tmp/pip-UESfj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:43 INFO - Running setup.py (path:/tmp/pip-YTbXOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:43 INFO - Running setup.py (path:/tmp/pip-6S04s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:43 INFO - Running setup.py (path:/tmp/pip-SsVS1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:43 INFO - Running setup.py (path:/tmp/pip-C2Hqth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:43 INFO - Running setup.py (path:/tmp/pip-dFdTOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:43 INFO - Running setup.py (path:/tmp/pip-t4Fskg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:43 INFO - Running setup.py (path:/tmp/pip-z4vCae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:44 INFO - Running setup.py (path:/tmp/pip-v8ksmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:44 INFO - Running setup.py (path:/tmp/pip-wVUyIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:44 INFO - Running setup.py (path:/tmp/pip-btLKSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:44 INFO - Running setup.py (path:/tmp/pip-oPM5yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:44 INFO - Running setup.py (path:/tmp/pip-PMTm22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:44 INFO - Running setup.py (path:/tmp/pip-SlN8Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:44 INFO - Running setup.py (path:/tmp/pip-iBOP7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:44 INFO - Running setup.py (path:/tmp/pip-DNfWMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:44 INFO - Running setup.py install for manifestparser 04:02:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:44 INFO - Running setup.py install for mozcrash 04:02:44 INFO - Running setup.py install for mozdebug 04:02:44 INFO - Running setup.py install for mozdevice 04:02:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:44 INFO - Running setup.py install for mozfile 04:02:45 INFO - Running setup.py install for mozhttpd 04:02:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for mozinfo 04:02:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for mozInstall 04:02:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for mozleak 04:02:45 INFO - Running setup.py install for mozlog 04:02:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for moznetwork 04:02:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for mozprocess 04:02:45 INFO - Running setup.py install for mozprofile 04:02:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:45 INFO - Running setup.py install for mozrunner 04:02:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:46 INFO - Running setup.py install for mozscreenshot 04:02:46 INFO - Running setup.py install for moztest 04:02:46 INFO - Running setup.py install for mozversion 04:02:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:46 INFO - Cleaning up... 04:02:46 INFO - Return code: 0 04:02:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:46 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 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:46 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 04:02:46 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 04:02:46 INFO - Using env: {'DISPLAY': ':0', 04:02:46 INFO - 'HOME': '/home/cltbld', 04:02:46 INFO - 'LANG': 'en_US.UTF-8', 04:02:46 INFO - 'LANGUAGE': 'en_US:en', 04:02:46 INFO - 'LOGNAME': 'cltbld', 04:02:46 INFO - 'MAIL': '/var/mail/cltbld', 04:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:46 INFO - 'MOZ_NO_REMOTE': '1', 04:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:46 INFO - 'NO_EM_RESTART': '1', 04:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:46 INFO - 'PWD': '/builds/slave/test', 04:02:46 INFO - 'SHELL': '/bin/bash', 04:02:46 INFO - 'SHLVL': '1', 04:02:46 INFO - 'TERM': 'linux', 04:02:46 INFO - 'TMOUT': '86400', 04:02:46 INFO - 'USER': 'cltbld', 04:02:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:46 INFO - '_': '/tools/buildbot/bin/python'} 04:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:46 INFO - Running setup.py (path:/tmp/pip-mFWBuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:46 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:46 INFO - Running setup.py (path:/tmp/pip-yEzUYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:46 INFO - Running setup.py (path:/tmp/pip-D9X8dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:46 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:46 INFO - Running setup.py (path:/tmp/pip-WeS6yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:46 INFO - Running setup.py (path:/tmp/pip-WHtQ9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:46 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:46 INFO - Running setup.py (path:/tmp/pip-FW2QIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:46 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)) 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:46 INFO - Running setup.py (path:/tmp/pip-DqtD4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:47 INFO - Running setup.py (path:/tmp/pip-V5T09t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:47 INFO - Running setup.py (path:/tmp/pip-5kMIx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:47 INFO - Running setup.py (path:/tmp/pip-Ew36ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:47 INFO - Running setup.py (path:/tmp/pip-I6_ctN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:47 INFO - Running setup.py (path:/tmp/pip-1cZuwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:47 INFO - Running setup.py (path:/tmp/pip-s5lbNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:47 INFO - Running setup.py (path:/tmp/pip-t17wX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:47 INFO - Running setup.py (path:/tmp/pip-1cufZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:47 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:47 INFO - Running setup.py (path:/tmp/pip-Th_E5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:47 INFO - Running setup.py (path:/tmp/pip-mwgYJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:47 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)) 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:02:47 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)) 04:02:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:02:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:49 INFO - Downloading blessings-1.6.tar.gz 04:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:49 INFO - Installing collected packages: blessings 04:02:49 INFO - Running setup.py install for blessings 04:02:49 INFO - Successfully installed blessings 04:02:49 INFO - Cleaning up... 04:02:49 INFO - Return code: 0 04:02:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:50 INFO - Reading from file tmpfile_stdout 04:02:50 INFO - Current package versions: 04:02:50 INFO - argparse == 1.2.1 04:02:50 INFO - blessings == 1.6 04:02:50 INFO - blobuploader == 1.2.4 04:02:50 INFO - docopt == 0.6.1 04:02:50 INFO - manifestparser == 1.1 04:02:50 INFO - mozInstall == 1.12 04:02:50 INFO - mozcrash == 0.17 04:02:50 INFO - mozdebug == 0.1 04:02:50 INFO - mozdevice == 0.48 04:02:50 INFO - mozfile == 1.2 04:02:50 INFO - mozhttpd == 0.7 04:02:50 INFO - mozinfo == 0.9 04:02:50 INFO - mozleak == 0.1 04:02:50 INFO - mozlog == 3.1 04:02:50 INFO - moznetwork == 0.27 04:02:50 INFO - mozprocess == 0.22 04:02:50 INFO - mozprofile == 0.28 04:02:50 INFO - mozrunner == 6.11 04:02:50 INFO - mozscreenshot == 0.1 04:02:50 INFO - mozsystemmonitor == 0.0 04:02:50 INFO - moztest == 0.7 04:02:50 INFO - mozversion == 1.4 04:02:50 INFO - psutil == 3.1.1 04:02:50 INFO - requests == 1.2.3 04:02:50 INFO - wsgiref == 0.1.2 04:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:50 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 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:50 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 04:02:50 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 04:02:50 INFO - Using env: {'DISPLAY': ':0', 04:02:50 INFO - 'HOME': '/home/cltbld', 04:02:50 INFO - 'LANG': 'en_US.UTF-8', 04:02:50 INFO - 'LANGUAGE': 'en_US:en', 04:02:50 INFO - 'LOGNAME': 'cltbld', 04:02:50 INFO - 'MAIL': '/var/mail/cltbld', 04:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:50 INFO - 'MOZ_NO_REMOTE': '1', 04:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:50 INFO - 'NO_EM_RESTART': '1', 04:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:50 INFO - 'PWD': '/builds/slave/test', 04:02:50 INFO - 'SHELL': '/bin/bash', 04:02:50 INFO - 'SHLVL': '1', 04:02:50 INFO - 'TERM': 'linux', 04:02:50 INFO - 'TMOUT': '86400', 04:02:50 INFO - 'USER': 'cltbld', 04:02:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:50 INFO - '_': '/tools/buildbot/bin/python'} 04:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 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)) 04:02:50 INFO - Cleaning up... 04:02:50 INFO - Return code: 0 04:02:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:02:50 INFO - Using env: {'DISPLAY': ':0', 04:02:50 INFO - 'HOME': '/home/cltbld', 04:02:50 INFO - 'LANG': 'en_US.UTF-8', 04:02:50 INFO - 'LANGUAGE': 'en_US:en', 04:02:50 INFO - 'LOGNAME': 'cltbld', 04:02:50 INFO - 'MAIL': '/var/mail/cltbld', 04:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:50 INFO - 'MOZ_NO_REMOTE': '1', 04:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:50 INFO - 'NO_EM_RESTART': '1', 04:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:50 INFO - 'PWD': '/builds/slave/test', 04:02:50 INFO - 'SHELL': '/bin/bash', 04:02:50 INFO - 'SHLVL': '1', 04:02:50 INFO - 'TERM': 'linux', 04:02:50 INFO - 'TMOUT': '86400', 04:02:50 INFO - 'USER': 'cltbld', 04:02:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:50 INFO - '_': '/tools/buildbot/bin/python'} 04:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:50 INFO - Downloading/unpacking jsonschema 04:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:52 INFO - Downloading/unpacking functools32 (from jsonschema) 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:52 INFO - warning: no files found matching '*.txt' 04:02:52 INFO - no previously-included directories found matching 'build' 04:02:52 INFO - no previously-included directories found matching 'dist' 04:02:52 INFO - no previously-included directories found matching '.git*' 04:02:52 INFO - Installing collected packages: jsonschema, functools32 04:02:52 INFO - Running setup.py install for functools32 04:02:52 INFO - warning: no files found matching '*.txt' 04:02:52 INFO - no previously-included directories found matching 'build' 04:02:52 INFO - no previously-included directories found matching 'dist' 04:02:52 INFO - no previously-included directories found matching '.git*' 04:02:52 INFO - Successfully installed jsonschema functools32 04:02:52 INFO - Cleaning up... 04:02:52 INFO - Return code: 0 04:02:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb512b21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24485a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, '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': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', '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 04:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:02:52 INFO - Using env: {'DISPLAY': ':0', 04:02:52 INFO - 'HOME': '/home/cltbld', 04:02:52 INFO - 'LANG': 'en_US.UTF-8', 04:02:52 INFO - 'LANGUAGE': 'en_US:en', 04:02:52 INFO - 'LOGNAME': 'cltbld', 04:02:52 INFO - 'MAIL': '/var/mail/cltbld', 04:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:52 INFO - 'MOZ_NO_REMOTE': '1', 04:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:52 INFO - 'NO_EM_RESTART': '1', 04:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:52 INFO - 'PWD': '/builds/slave/test', 04:02:52 INFO - 'SHELL': '/bin/bash', 04:02:52 INFO - 'SHLVL': '1', 04:02:52 INFO - 'TERM': 'linux', 04:02:52 INFO - 'TMOUT': '86400', 04:02:52 INFO - 'USER': 'cltbld', 04:02:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:52 INFO - '_': '/tools/buildbot/bin/python'} 04:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:53 INFO - Downloading/unpacking flake8 04:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 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 04:02:55 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 04:02:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:55 INFO - no previously-included directories found matching 'docs/_build' 04:02:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:55 INFO - Running setup.py install for pep8 04:02:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:55 INFO - no previously-included directories found matching 'docs/_build' 04:02:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:55 INFO - Cleaning up... 04:02:55 INFO - Return code: 0 04:02:55 INFO - Running post-action listener: _resource_record_post_action 04:02:55 INFO - Running post-action listener: _start_resource_monitoring 04:02:56 INFO - Starting resource monitoring. 04:02:56 INFO - ##### 04:02:56 INFO - ##### Running install step. 04:02:56 INFO - ##### 04:02:56 INFO - Running pre-action listener: _resource_record_pre_action 04:02:56 INFO - Running main action method: install 04:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:56 INFO - Reading from file tmpfile_stdout 04:02:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:56 INFO - Reading from file tmpfile_stdout 04:02:56 INFO - Output received: 04:02:56 INFO - Usage: mozinstall [options] installer 04:02:56 INFO - Options: 04:02:56 INFO - -h, --help show this help message and exit 04:02:56 INFO - -d DEST, --destination=DEST 04:02:56 INFO - Directory to install application into. [default: 04:02:56 INFO - "/builds/slave/test"] 04:02:56 INFO - --app=APP Application being installed. [default: firefox] 04:02:56 INFO - mkdir: /builds/slave/test/build/application 04:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:03:11 INFO - Reading from file tmpfile_stdout 04:03:11 INFO - Output received: 04:03:11 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:11 INFO - Running post-action listener: _resource_record_post_action 04:03:11 INFO - ##### 04:03:11 INFO - ##### Running run-tests step. 04:03:11 INFO - ##### 04:03:11 INFO - Running pre-action listener: _resource_record_pre_action 04:03:11 INFO - Running main action method: run_tests 04:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:11 INFO - Python 2.7.3 04:03:11 INFO - Return code: 0 04:03:11 INFO - grabbing minidump binary from tooltool 04:03: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:11 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d7410>, '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 0x24d8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:11 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 04:03:11 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 04:03:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:11 INFO - Return code: 0 04:03:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:03:12 INFO - Return code: 0 04:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 04:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 04:03:12 INFO - Using env: {'DISPLAY': ':0', 04:03:12 INFO - 'HOME': '/home/cltbld', 04:03:12 INFO - 'LANG': 'en_US.UTF-8', 04:03:12 INFO - 'LANGUAGE': 'en_US:en', 04:03:12 INFO - 'LOGNAME': 'cltbld', 04:03:12 INFO - 'MAIL': '/var/mail/cltbld', 04:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:12 INFO - 'MOZ_NO_REMOTE': '1', 04:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:12 INFO - 'NO_EM_RESTART': '1', 04:03:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:12 INFO - 'PWD': '/builds/slave/test', 04:03:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:12 INFO - 'SHELL': '/bin/bash', 04:03:12 INFO - 'SHLVL': '1', 04:03:12 INFO - 'TERM': 'linux', 04:03:12 INFO - 'TMOUT': '86400', 04:03:12 INFO - 'USER': 'cltbld', 04:03:12 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287', 04:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:12 INFO - '_': '/tools/buildbot/bin/python'} 04:03:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 04:03:13 INFO - mozversion application_buildid: 20160605010644 04:03:13 INFO - mozversion application_changeset: 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 04:03:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:03:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:13 INFO - mozversion application_name: Firefox 04:03:13 INFO - mozversion application_remotingname: firefox-dev 04:03:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:03:13 INFO - mozversion application_vendor: Mozilla 04:03:13 INFO - mozversion application_version: 48.0a2 04:03:13 INFO - mozversion platform_buildid: 20160605010644 04:03:13 INFO - mozversion platform_changeset: 072ce9419eaaf6be1cdbd589176feec2b7d8ec07 04:03:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:03:13 INFO - mozversion platform_version: 48.0a2 04:03:13 INFO - using testdate: 1465124593 04:03:13 INFO - actual date: 1465124593 04:03:13 INFO - starting webserver on 'localhost:42775' 04:03:13 INFO - SUITE-START | Running 2 tests 04:03:13 INFO - TEST-START | dromaeo_css 04:03:13 INFO - operating with platform_type : linux_ 04:03:13 INFO - Initialising browser for dromaeo_css test... 04:03:13 INFO - TEST-INFO | started process 7675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4lFYn/profile http://localhost:42775/getInfo.html) 04:03:17 INFO - PROCESS | 7675 | 04:03:17 INFO - PROCESS | 7675 | (process:7754): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:03:17 INFO - PROCESS | 7675 | __metrics Screen width/height:1600/1200 04:03:17 INFO - PROCESS | 7675 | colorDepth:24 04:03:17 INFO - PROCESS | 7675 | Browser inner width/height: 1024/697 04:03:17 INFO - PROCESS | 7675 | __metrics 04:03:18 ERROR - PROCESS | 7675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 04:03:19 INFO - TEST-INFO | 7675: exit 0 04:03:19 INFO - Browser initialized. 04:03:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:19 INFO - TEST-INFO | started process 7806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4lFYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:21 INFO - PROCESS | 7806 | 04:03:21 INFO - PROCESS | 7806 | (process:7874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:03:31 INFO - PROCESS | 7806 | RSS: Main: 152272896 04:03:31 INFO - PROCESS | 7806 | 04:04:20 INFO - PROCESS | 7806 | 1465124660793 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:06:28 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42775/tests/dromaeo/cssquery-ext.html) 04:06:29 INFO - PROCESS | 7806 | RSS: Main: 155983872 04:06:29 INFO - PROCESS | 7806 | 04:09:31 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-ext.html (next: http://localhost:42775/tests/dromaeo/cssquery-jquery.html) 04:09:31 INFO - PROCESS | 7806 | RSS: Main: 153632768 04:09:31 INFO - PROCESS | 7806 | 04:12:33 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42775/tests/dromaeo/cssquery-mootools.html) 04:12:34 INFO - PROCESS | 7806 | RSS: Main: 153313280 04:12:34 INFO - PROCESS | 7806 | 04:15:35 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42775/tests/dromaeo/cssquery-prototype.html) 04:15:36 INFO - PROCESS | 7806 | RSS: Main: 153047040 04:15:36 INFO - PROCESS | 7806 | 04:18:38 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42775/tests/dromaeo/cssquery-yui.html) 04:18:39 INFO - PROCESS | 7806 | RSS: Main: 154648576 04:18:39 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | Cycle 1(1): loaded http://localhost:42775/tests/dromaeo/cssquery-yui.html (next: http://localhost:42775/tests/dromaeo/cssquery-dojo.html) 04:21:41 INFO - PROCESS | 7806 | RSS: Main: 156053504 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | __start_tp_report 04:21:41 INFO - PROCESS | 7806 | _x_x_mozilla_page_load 04:21:41 INFO - PROCESS | 7806 | _x_x_mozilla_page_load_details 04:21:41 INFO - PROCESS | 7806 | |i|pagename|runs| 04:21:41 INFO - PROCESS | 7806 | |0;dojo.html;3368.9663103368966;3416.812075335857;3443.466262729277;3461.5846098468187;3469.0286719718456;5628.296462942132;5641.464060914212;5649.830505084854;5675.460831221033;5689.431056894319;5632.577556683255;5654.038813401721;5673.602847800646;5678.34699009614;5708.714564271791;5062.114130027249;5103.974480127594;5154.098032844256;5157.76790044447;5163.7418129093585;5086.97456512717;5191.662541934762;5286.180642000496;5291.28567643367;5297.735113244342;5195.766190521435;5237.45006774289;5269.6311258211945;5351.7324133793345;5363.249145119687;5227.660202086871;5271.578273738091;5278.577713782888;5281.656692314988;5299.761510732026;5102.056119617845;5118.6416950813455;5174.97412512935;5180.896382072375;5209.609279304067;5473.616846820684;5584.5253153482;5591.133374326986;5594.496495315441;5670.858228544319;6018.789342373039;6063.151158837766;6066.6663333516635;6075.27096748393;6092.756289748405;6094.664793436359;6107.664078475682;6110.5111591073055;6112;6140.140380346755;5638.718064096779;5650.152477128422;5664.20701101846;5705.115707065412;5788.0160372737155;6229.1590635264565;6247.094171345129;6268.216472940882;6275.623462592259;6297.433231009231;5952.285725712942;5965.522758179335;6025.879482410327;6027.6684782336515;6037.78867739627;6108.144859719643;6124.938750612526;6128.93092736735;6131.621347939075;6141.877162456726;6057.42454466825;6061.999770037983;6062.848428789227;6075.422834830772;6086.391360863879;5997.610155339889;6027.8794424111275;6051.8487037823525;6059.303180134253;6106.206193194945;4631.282151266559;4643.141018911512;4657.883552911204;4661.463931647836;4673.018666080094;4159.604837540489;4171.937420938689;4191.7694526801315;4199.580041995837;4215.59951804578;5833.329167145747;5868.823935281948;5904.261967254093;5926.7925622603;5949.167116603679;6000.909986350208;6024.427679370453;6089;6099.207103076572;6135.7852475164045;5823.272090988627;5848.883022339614;5858.326292476335;5859.44335288147;5861.6189947653265;4943;5086.160783470686;5146.022255771466;5150.562202212854;5153.819616313411;6321.810345689637;6358.77744278948;6363.013732871413;6386.329435409308;6390.84022899422;6015.879682406415;6115.960286751174;6130.141780150693;6139.201903752483;6143.539234557516;6358.523110766619;6412.9679351602945;6457.09600655918;6459.515536334888;6482.935170648422;5963.970180149072;5989.041753319448;6006.3693312201585;6030.547708921936;6032.728527216374;5916.852078698067;6097.146399504161;6117.051856962178;6121.877562448815;6134.723937422737;5859.179714839841;5863.501602363847;5866.67733274674;5879.323877754113;5901.3213480448585;5813.244278243801;5857.5313974881055;5867;5868.383819699041;5879.176915231957;5725.541956643542;5754.798582049608;5762.394948530512;5808.738606762621;5849.093390524476;5982.940170598413;6019.428154325332;6023.969880150571;6042.607230530001;6045.75816967334;5882;5888.882222355443;5899.587028907935;5903.704814759159;5905.793297234576 04:21:41 INFO - PROCESS | 7806 | |1;ext.html;663.7909058646526;689.2418339826191;696.6551556979296;715.9118140426551;748.7454265549713;39039;39707.80146099273;39932.201355972866;40054.79972600133;40055;42877.57122428775;43662.56337436625;43712.562874371244;43770;43838.34242486365;8676.045634980163;8867.600957956907;8867.822643547126;8872.245859101984;8891.644334226623;8960.686375976842;8979.775505612346;9081.137291957253;9105.043970383114;9128.361014728971;9023.233025192867;9156.725298241063;9169.08309169081;9174.128457796533;9181.357304988653;8761.123887611251;8782.824343513126;8787.0334263231;8806.339524535653;8816.779580510538;8990.730278091602;9098.818023639556;9120.817583648357;9124.45253284805;9157.587908544132;42662.36006459906;42842.78578607087;42883.57116428827;43155.35266970998;43482.34776478355;3500.702440292578;3510.9824450877836;3781;3874.1089549403796;4034.6570541503716;31896.043118706475;31990.84004579962;32105.678943210503;32115;33015;4540.682152249344;4566.977165114186;4614.884627884329;4625.861224163281;4672.13565490382;244645;247162;247473;248036;248283;39441.211175776894;60926.69536652377;61297.693511532154;61543.6922815392;61911.380886191466;36018.45972310418;36111;36197.638023619955;36209.45685814715;36273;16526.091064991302;16568.17159142038;16652.75020874688;16686.916565417094;16749.413770517975;14088.084274522123;14108.647283817987;14109.435622574982;14166.716665666629;14210.644733881736;9035.50304733246;9144.908550914406;9165.770855728526;9283.90716092844;9356.345055846026;3478.6869181773254;3560.092176494977;3592.946105808415;3600.71194304455;3628.691561217326;1081.3674000709516;1150.4937827356105;1167.8802972604865;1242.9937850310691;1274.4774642396574;34205.82897085549;36565;36568.45147322792;36798.264034719155;37018.62981370152;1254.8305978692943;1302.5636411802152;1309.4762095162012;1332.5402736056046;1346.6767975685962;16718.665626687398;16769.91615041917;16773.496795096165;16788.91605541989;16847.494575162764;540005;547539;551887;556883;558484;52593.7370313146;53009.734951324994;53069.20396193983;53091.46908530942;53476.73261633667;1430.399232322427;1531.9387224510895;1540.0836502281124;1545.2042198267677;1547.1490680125885;31628.841855790575;32128.839355803073;32151.51772723458;32268.19329516781;32315.676843231267;53176;53590.1961470586;53625;54023.45976540184;54056.72971635117;485261;491339;491340;491832;493608;30427;30434.391312174077;30837.537436938914;30864.074077776804;30905.845470772503;49506;49766;50122.49877501178;50275.49724502708;50513.49486505235;40935.38596920989;41733.791331043154;41816.79091604644;43062;43279.567204327555;41334.586654133076;42547.787261063495;42646.57353426426;42700.78649606732;42798.57201427946;42767.572324276356;43227;43416.34875476807;43744.78127609342;43803.34294985514;37054.44418333673;37165.25669486541;37471.43792843164;37700.43449348207;37989.620103799716;28595.428091438473;28809.56785648259;29108.563371549866;29220.56169157507;29465.11604651864 04:21:41 INFO - PROCESS | 7806 | |2;jquery.html;419.92441360555085;420.14156733180994;430.9612134907858;434.20757118259166;442.32545368313316;18858.33995810147;19078.713819292687;19251.903740481313;19324.806751932476;19479.41561753148;18622.255109795628;18844.905775471103;19632.60734785307;20376.694349584766;20385.694214586754;5842.094475356316;5850.414958504158;5906.940930590682;5953.434423729739;6031.306399764039;5884.058550631899;5970.910436343436;6001.189839371695;6003.279606447232;6006.519478441714;5709.71451427429;5837.416258374171;5894.587378883459;5993.4006599340155;5993.550483713717;5784.566157538202;5796.2464879565805;5803.73883175256;5822.796202132948;5830.970845145789;5161.406438259611;5194.142966410538;5210.713410762407;5349.866253343658;5353.384360798519;23122.42193945148;23382.64926026111;23879;23923;24025;2566.563684173695;2597.2597809624167;2690.233283514209;2699.9730002699916;3051.8016328938547;7655.1962043985695;7683.654235559413;11919;12913.096083274175;15238.466653667068;2066.2974588639786;2078.4076538186546;2163.134746101572;2195.1877805212175;2302.1712183613886;80147.99999999942;80451.19548804495;80635;82451.17548824495;82885.58557207236;10923.836142457869;10979.62754655668;11555.480003399867;11564.710882227844;11819.936205741353;15548;15553.922230389002;15642.45251416195;15692.058476491447;15709.607259818597;8403.537805420638;8479.406441549032;8537.317014638815;8627.266682332072;8644.95677521621;7995.560244186509;8060.959695201604;8117.594120294079;8213.712520061768;8378;4769.904601907942;4867.075255701406;4869.342638743795;4880.731559764247;4903.190973489334;1965.115697935906;2004.9799502005085;2014.959700806005;2059.9588008239753;2060.701198326234;968.3995922527937;1048.1091072588392;1071.9196060295353;1136.5510623303749;1145.66202970124;19234.71147932782;19330.4200873974;19834.107465164103;19981.800181997995;20047.456048664822;1058.8094143054325;1089.0851684584986;1109.7225693576606;1155.0817100405197;1162.7558212775411;10903.727406814734;11137.554497820158;11229.27009744364;11300;11312.434378281054;559178;562973;589250;592684;602136;74681;81920;84367.57816211002;93450.45846790796;96817.51591241999;1091.9890801092047;1115.4924509348389;1131.7000994736402;1135.6649788312468;1141.463512149272;17422.31991207923;17716;17758.11209439549;17961.550961226072;18322.358717444826;40345.39481907833;40536.3919541213;40706.796466017484;41524.3771343424;41607.79196104;58623.4137658618;60328;61001;61088.38911611005;61369.69315153396;8886.24466920319;8889.111088891059;8968.730938071869;8974.570055829057;9046.728598142066;12050.819237711617;12726.554570589984;12888.097833151589;12926.676833078873;12960.351982400654;10262.743431413975;10793.892061079288;10980.121590272918;11079;11154.330740155616;11417.714557136138;11438.542458301576;11588.47851846652;11594;11925.284482931052;11132;11202.943985280348;11280.830787538029;11342.716432089264;11407.543698251977;8734.213920747163;8789.868151977853;8928.955355223183;9034.45793252407;9094.727158185266;10777.191710621579;11110.11119110453;11149.331040137618;11221.102311815199;11352.375619341015 04:21:41 INFO - PROCESS | 7806 | |3;mootools.html;1568.7568426893831;1611.3393508661443;1775.2987569909885;1832.2945665918617;1835.1008006077009;7220.927790722091;8163.061247956487;8190.2628763411285;8334.958325208374;8339.374546908983;8233.300169485601;8272.71045513407;8322.708705195319;8327.20891515305;8338.332933365331;2334.6498025296214;2363.291012696184;2368.786809187173;2375.8574485530835;2383.249276477904;2389.629607410854;2406.74729153439;2415.5531226723024;2420.878956052199;2431.0761910473993;2379.773921477457;2394.521095780851;2413.9275821725287;2414.637804329347;2427.757224277576;2380.9285721428387;2382.273406610983;2404.987975060122;2418.22616762636;2419.8790060496904;2387.9880600596885;2405.074046492113;2407.3018824540864;2417.2506522977933;2421.2373102472666;8521.233089022018;8537.914620853837;8541.231289183941;8541.402101852873;8547.931508561429;5229.843104706865;5375.596830237709;5401.513863752281;5403.864903377408;5415.620906536544;3537.9032499924847;3547.6984456321243;3571.8571257149683;3610.1877077657578;3631.5279013728045;1151.936643484608;1194.3669854976877;1197.4192516629428;1198.4007996002;1237.7153254751368;12019.399030048462;12055.095867809949;12100.273983561014;12111.394430278451;12144.939275303655;4692.296155576691;4720.457147428021;4778.160408242851;4790.113828941588;4827.951720482821;10216.438095904648;10252.6411575596;10257.846132308021;10273.845892311621;10283.331583447052;5367.838964830983;5379.865503362447;5403.891922161613;5409.215663728737;5409.513143817076;4374.365716971021;4717.8112875485285;4748.833790817304;4825;4966.255061740768;4084.7957602119777;4139.373863664689;4217.493900731932;4228.6617070634275;4280.122574872206;1262.0976002158318;1264.342541878218;1268.2770820632336;1270.7776139175608;1304.0284987684047;1067.5409573883305;1067.6209945469402;1069.2889228663007;1083.4311986207304;1084.9349039057681;5808.593398462067;5867.647941123546;5965.105234214902;5966.671833049137;6068.089786531968;484.3630625727228;485.83724452308167;490.4751915450505;492.0257889378978;498.43427709549195;4187.1625674865145;4211.894702632459;4228.154369126187;4243.936340954888;4331.5884990925815;10052.095311422006;10216.080552750289;10314.535845886952;10391.37651740898;10399.740006499898;10233.232507561814;10247.59009639621;10251.077403033614;10263.538140783534;10269.845952310721;7795.298423141944;7859.4891332063235;7952.801179970431;7999.120096789348;8054.798630034296;5799.594028418139;5858.297004359504;5874.941250587611;5885.470307672159;5956.612820166675;9003.414778039407;9040.502772347583;9296.535173241176;9437.339386242897;9453.574589143642;9170.862437063315;9365.157135857806;9378.343515954091;9439.669611563562;9585.952070239604;6826.317368263134;7233.963830180815;7354.448416368687;7420.851582968203;7474.925250747423;8090.919090809017;8091.514509129235;8130.918690813016;8153.673853046049;8164.387670924586;7188.101487314086;7374.225706300761;7390.704371825067;7420.5176663516695;7570;7211.819704507429;7308.269173082649;7332.670029848563;7363.410927125924;7432.777016689508;6666.333366663295;6712.865742685217;6829.556078854858;6829.8634027318185;6898.965505172643;5081.695098294114;5091.205827619517;5179.352580927384;5195.168772996302;5288.286081378965;4920.31115643803;4977.751112444291;4999.10016197088;5110.872228194325;5135.35808023997 04:21:41 INFO - PROCESS | 7806 | |4;prototype.html;352.1021395441623;356.4350504450447;357.98389072491733;362.4219370104685;367.82528299057935;6436.613803171801;6512.934870651292;6532.967335163317;6552.67236638168;6634.80573496771;6563.803085907431;6581.341865813416;6610.40506354428;6640.900386494206;6643.236027856798;4914.746739581402;4938.086454006002;4940.407151141868;4947.084789313971;4967;4943.4067911850625;4956.752162391866;4959.181735013736;4961.082199793032;4971.328870602477;4879.951200487985;4887.535684110004;4909.067277217335;4910;4921.876953076184;4726.905461890743;4861.8784530386665;4928;4936.728479933602;4937.901241975158;4204.07510347723;4214.093969796509;4219.282721937278;4221.514525829538;4255.0426154115385;6324.557280990332;6330.430261276507;6339.397757213057;6340.4293613575;6347.174867267272;5675.716214189315;5695.117256825199;5728.828135155952;5739.971300143473;5741.511971482429;6844.657767111625;6918;6926.445884329292;6930.27232140623;6950.992106144631;4575.6339492840825;4725.314829349725;4747.477777444478;4749.430068391815;4754.286856971447;7263.709451621929;7285.635718214121;7305.123385193758;7311.488195826294;7355.889661655079;4795.20879054952;4821.831235906727;4829.396325459317;4833.73414462208;4834.734089625034;4899.240617704261;4899.583535399531;4900.828471003498;4903.289023091632;4904.852854414374;5730.512906402919;5732.082866741384;5733.312002559636;5735.053716136791;5744.942550574524;6880.69036893341;7012.403945664676;7027.191872934575;7052.788416347517;7056;1707.9743803842953;1714.8285171482753;1724.4912750738563;1725.8360455756683;1729.982700172982;1048.8793788714395;1103.5254840418536;1113.3486910157649;1123.9606613768478;1129.8757136714955;6761.966190169116;6929.44564434844;6935.653217339213;7011.228764835864;7020.403265722471;7231.710731570678;7257.346838784535;7260.056192694916;7276.8180795479475;7303.525270857377;6837.555558888656;6876.931230687629;6878.8624227516175;6898.413634840995;6905.37851593359;3842.4044273137706;3884.2814079395403;3889.2999260132883;3912.1002169501176;3916.060145565044;7643.541387516767;7646.9617651912495;7662.3487003604205;7672.616369181518;7675.15573286938;7483.775486735407;7512.699492020367;7521.586312752742;7523.285287897641;7537.585432801139;7612.8477430452185;7621.428392870557;7627.999999999889;7628.313451789366;7639.961800190964;6960.686769095301;7233.529820561646;7240.239774823778;7240.8913866290995;7258.564486130849;7196.10048743907;7214.170370407261;7224.13310402734;7230.674619642234;7231.746888858865;7509.361704254981;7521.172671006294;7522.172561018174;7533.472656913963;7536.359409450258;4733.290006499053;4785.928211076906;4786.090642777861;4790.113828941657;4802.615790736802;7130.144382674112;7259.092613423322;7275.454340924558;7289.489735718449;7318.597477138808;7012.298770122947;7037;7042.436605071684;7051.330123638246;7055.3650171484815;6973.3375329343635;6989.47578931572;7049.400800931979;7051.717931282691;7073.292670732885;6931.272216417406;6943.236244013256;6955.339242771928;6957.304269573002;6964.965175174092;6948.374646281859;7109.822254443473;7109.964450177716;7124.323189297009;7126.608036558039;6795;6906.8618627626165;6936.7572134975035;6967.442604591519;6972.4073453757 04:21:41 INFO - PROCESS | 7806 | |5;yui.html;815.987760183597;823.2467292427428;860.5869182792255;896.0949441064523;898.4160295807724;15011.849881501183;15120.168390738505;15197.392104315828;15737.527874163765;15763;14747.705045899102;14750.926245368784;14753.704925901475;14769.704605907875;14809.777853332182;727.37445796615;886.1979908183073;893.1515060692336;900.8153328567628;902.8104098139365;892.7768057985504;892.9062448442918;896.3008853094564;896.4307664632939;903.4172958441801;935.3732998890725;948.5115165689675;949.6296444386695;949.8480243161096;950.0974074629096;939.6523286384047;942.7643089227693;945.7257395355339;947.4599478297373;951.9904800952006;686.0292685849518;690.2579726793666;691.4192078653905;691.872003679321;693.2789898505548;15427.3829046838;15491;15516.61208469786;15556.766648500281;15561.443855614349;13848.515301964484;13921.23433211173;14046.578602641937;14066.2966851657;14110.85889141116;11007.229493935427;11137.721556961142;11166.441677916153;11207.831882521768;11281.943590281997;3962.0689138052535;4009.7393669411395;4035.1122752994293;4054.0675644601906;4078.8164532595806;55486;55625;56004.71997639986;56427.71786141125;58581;11616.593419230287;11683.415829208505;11842.171048026728;11920.165588408729;12015.639530814089;19899.303524376577;19965.900170499055;19999.400017999484;20002;20474.79525204729;8661.220490155916;8832.8675069874;8835.425697329652;8836.55817209137;9057.81884362309;4690.718556886598;4734.573888350065;4879.316895634614;4900.411950565955;5106.846794596168;3326.334733053399;3333.1333853198344;3358.462645976681;3367.696907278357;3369.4945758136478;642.7461152844601;655.4887187993373;656.7208936202095;671.6104659297596;672.5998031171445;631.2298995225817;642.6208536963121;667.1293961380348;706.5654622407183;728.049697305426;9822.974841166539;10157.746056348651;10252.948735256276;10286.434246116385;10335.793284134275;651.4072194303257;717.8851383778571;790.7864876483433;792.2671528835918;808.3533173461208;4392.1874453226255;4821.879453013633;4857.1742803723455;4869.318295438641;4965.453800081988;66077.66961165164;66113;66405.66797165983;67214.3278567208;67491.66254168795;56568.43431565714;56773.716131419904;57603.423965760645;58044.4195558039;58089.41910580925;54830.725846370515;54862.72568637131;55429;55602;55832.441675583534;9361.485118318558;9506.524673766422;9511.619535218513;9535.856962145712;9684.46735429558;39392.40911386389;40176.397354040295;40400.79799601101;41221;41231.7938410306;46815.765921170176;52941.47058529365;52985;53489.19766203432;54767.45232547623;11058.060064894575;11089.057430118208;11114.722131946766;12739.936300318439;12939.741205176033;13808.723825523633;15104.54686359411;15222.771658425354;15320.846791531942;15744.448944286894;13160.47358105665;13478.258695771827;13981.300934953008;13981.44074237019;14065.226412547;13863.376148073563;13878.791818122534;13892.652683682989;13919.721605568035;13993;12759.808602870778;12837.165584236995;13049;13227.470901163846;14374.425022999381;10769.892301076889;10947.726306842393;11132.443377831238;11614.419279036183;11648.41757912118;10464.215183861088;10721.195910306915;11057.447127643425;11078.833817492905;11087.113030957666 04:21:41 INFO - PROCESS | 7806 | __end_tp_report 04:21:41 INFO - PROCESS | 7806 | __start_cc_report 04:21:41 INFO - PROCESS | 7806 | _x_x_mozilla_cycle_collect,324 04:21:41 INFO - PROCESS | 7806 | __end_cc_report 04:21:41 INFO - PROCESS | 7806 | __startTimestamp1465125701847__endTimestamp 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | ------- Summary: start ------- 04:21:41 INFO - PROCESS | 7806 | Number of tests: 6 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#0] dojo.html Cycles:165 Average:5665.50 Median:5868.38 stddev:630.96 (10.8%) stddev-sans-first:606.63 04:21:41 INFO - PROCESS | 7806 | Values: 3369.0 3416.8 3443.5 3461.6 3469.0 5628.3 5641.5 5649.8 5675.5 5689.4 5632.6 5654.0 5673.6 5678.3 5708.7 5062.1 5104.0 5154.1 5157.8 5163.7 5087.0 5191.7 5286.2 5291.3 5297.7 5195.8 5237.5 5269.6 5351.7 5363.2 5227.7 5271.6 5278.6 5281.7 5299.8 5102.1 5118.6 5175.0 5180.9 5209.6 5473.6 5584.5 5591.1 5594.5 5670.9 6018.8 6063.2 6066.7 6075.3 6092.8 6094.7 6107.7 6110.5 6112.0 6140.1 5638.7 5650.2 5664.2 5705.1 5788.0 6229.2 6247.1 6268.2 6275.6 6297.4 5952.3 5965.5 6025.9 6027.7 6037.8 6108.1 6124.9 6128.9 6131.6 6141.9 6057.4 6062.0 6062.8 6075.4 6086.4 5997.6 6027.9 6051.8 6059.3 6106.2 4631.3 4643.1 4657.9 4661.5 4673.0 4159.6 4171.9 4191.8 4199.6 4215.6 5833.3 5868.8 5904.3 5926.8 5949.2 6000.9 6024.4 6089.0 6099.2 6135.8 5823.3 5848.9 5858.3 5859.4 5861.6 4943.0 5086.2 5146.0 5150.6 5153.8 6321.8 6358.8 6363.0 6386.3 6390.8 6015.9 6116.0 6130.1 6139.2 6143.5 6358.5 6413.0 6457.1 6459.5 6482.9 5964.0 5989.0 6006.4 6030.5 6032.7 5916.9 6097.1 6117.1 6121.9 6134.7 5859.2 5863.5 5866.7 5879.3 5901.3 5813.2 5857.5 5867.0 5868.4 5879.2 5725.5 5754.8 5762.4 5808.7 5849.1 5982.9 6019.4 6024.0 6042.6 6045.8 5882.0 5888.9 5899.6 5903.7 5905.8 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#1] ext.html Cycles:180 Average:58585.58 Median:42597.18 stddev:119750.78 (281.1%) stddev-sans-first:120007.75 04:21:41 INFO - PROCESS | 7806 | Values: 663.8 689.2 696.7 715.9 748.7 39039.0 39707.8 39932.2 40054.8 40055.0 42877.6 43662.6 43712.6 43770.0 43838.3 8676.0 8867.6 8867.8 8872.2 8891.6 8960.7 8979.8 9081.1 9105.0 9128.4 9023.2 9156.7 9169.1 9174.1 9181.4 8761.1 8782.8 8787.0 8806.3 8816.8 8990.7 9098.8 9120.8 9124.5 9157.6 42662.4 42842.8 42883.6 43155.4 43482.3 3500.7 3511.0 3781.0 3874.1 4034.7 31896.0 31990.8 32105.7 32115.0 33015.0 4540.7 4567.0 4614.9 4625.9 4672.1 244645.0 247162.0 247473.0 248036.0 248283.0 39441.2 60926.7 61297.7 61543.7 61911.4 36018.5 36111.0 36197.6 36209.5 36273.0 16526.1 16568.2 16652.8 16686.9 16749.4 14088.1 14108.6 14109.4 14166.7 14210.6 9035.5 9144.9 9165.8 9283.9 9356.3 3478.7 3560.1 3592.9 3600.7 3628.7 1081.4 1150.5 1167.9 1243.0 1274.5 34205.8 36565.0 36568.5 36798.3 37018.6 1254.8 1302.6 1309.5 1332.5 1346.7 16718.7 16769.9 16773.5 16788.9 16847.5 540005.0 547539.0 551887.0 556883.0 558484.0 52593.7 53009.7 53069.2 53091.5 53476.7 1430.4 1531.9 1540.1 1545.2 1547.1 31628.8 32128.8 32151.5 32268.2 32315.7 53176.0 53590.2 53625.0 54023.5 54056.7 485261.0 491339.0 491340.0 491832.0 493608.0 30427.0 30434.4 30837.5 30864.1 30905.8 49506.0 49766.0 50122.5 50275.5 50513.5 40935.4 41733.8 41816.8 43062.0 43279.6 41334.6 42547.8 42646.6 42700.8 42798.6 42767.6 43227.0 43416.3 43744.8 43803.3 37054.4 37165.3 37471.4 37700.4 37989.6 28595.4 28809.6 29108.6 29220.6 29465.1 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#2] jquery.html Cycles:180 Average:31552.84 Median:23974.00 stddev:95362.99 (397.8%) stddev-sans-first:95601.86 04:21:41 INFO - PROCESS | 7806 | Values: 419.9 420.1 431.0 434.2 442.3 18858.3 19078.7 19251.9 19324.8 19479.4 18622.3 18844.9 19632.6 20376.7 20385.7 5842.1 5850.4 5906.9 5953.4 6031.3 5884.1 5970.9 6001.2 6003.3 6006.5 5709.7 5837.4 5894.6 5993.4 5993.6 5784.6 5796.2 5803.7 5822.8 5831.0 5161.4 5194.1 5210.7 5349.9 5353.4 23122.4 23382.6 23879.0 23923.0 24025.0 2566.6 2597.3 2690.2 2700.0 3051.8 7655.2 7683.7 11919.0 12913.1 15238.5 2066.3 2078.4 2163.1 2195.2 2302.2 80148.0 80451.2 80635.0 82451.2 82885.6 10923.8 10979.6 11555.5 11564.7 11819.9 15548.0 15553.9 15642.5 15692.1 15709.6 8403.5 8479.4 8537.3 8627.3 8645.0 7995.6 8061.0 8117.6 8213.7 8378.0 4769.9 4867.1 4869.3 4880.7 4903.2 1965.1 2005.0 2015.0 2060.0 2060.7 968.4 1048.1 1071.9 1136.6 1145.7 19234.7 19330.4 19834.1 19981.8 20047.5 1058.8 1089.1 1109.7 1155.1 1162.8 10903.7 11137.6 11229.3 11300.0 11312.4 559178.0 562973.0 589250.0 592684.0 602136.0 74681.0 81920.0 84367.6 93450.5 96817.5 1092.0 1115.5 1131.7 1135.7 1141.5 17422.3 17716.0 17758.1 17961.6 18322.4 40345.4 40536.4 40706.8 41524.4 41607.8 58623.4 60328.0 61001.0 61088.4 61369.7 8886.2 8889.1 8968.7 8974.6 9046.7 12050.8 12726.6 12888.1 12926.7 12960.4 10262.7 10793.9 10980.1 11079.0 11154.3 11417.7 11438.5 11588.5 11594.0 11925.3 11132.0 11202.9 11280.8 11342.7 11407.5 8734.2 8789.9 8929.0 9034.5 9094.7 10777.2 11110.1 11149.3 11221.1 11352.4 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#3] mootools.html Cycles:180 Average:5645.41 Median:488.16 stddev:3084.09 (631.8%) stddev-sans-first:3077.53 04:21:41 INFO - PROCESS | 7806 | Values: 1568.8 1611.3 1775.3 1832.3 1835.1 7220.9 8163.1 8190.3 8335.0 8339.4 8233.3 8272.7 8322.7 8327.2 8338.3 2334.6 2363.3 2368.8 2375.9 2383.2 2389.6 2406.7 2415.6 2420.9 2431.1 2379.8 2394.5 2413.9 2414.6 2427.8 2380.9 2382.3 2405.0 2418.2 2419.9 2388.0 2405.1 2407.3 2417.3 2421.2 8521.2 8537.9 8541.2 8541.4 8547.9 5229.8 5375.6 5401.5 5403.9 5415.6 3537.9 3547.7 3571.9 3610.2 3631.5 1151.9 1194.4 1197.4 1198.4 1237.7 12019.4 12055.1 12100.3 12111.4 12144.9 4692.3 4720.5 4778.2 4790.1 4828.0 10216.4 10252.6 10257.8 10273.8 10283.3 5367.8 5379.9 5403.9 5409.2 5409.5 4374.4 4717.8 4748.8 4825.0 4966.3 4084.8 4139.4 4217.5 4228.7 4280.1 1262.1 1264.3 1268.3 1270.8 1304.0 1067.5 1067.6 1069.3 1083.4 1084.9 5808.6 5867.6 5965.1 5966.7 6068.1 484.4 485.8 490.5 492.0 498.4 4187.2 4211.9 4228.2 4243.9 4331.6 10052.1 10216.1 10314.5 10391.4 10399.7 10233.2 10247.6 10251.1 10263.5 10269.8 7795.3 7859.5 7952.8 7999.1 8054.8 5799.6 5858.3 5874.9 5885.5 5956.6 9003.4 9040.5 9296.5 9437.3 9453.6 9170.9 9365.2 9378.3 9439.7 9586.0 6826.3 7234.0 7354.4 7420.9 7474.9 8090.9 8091.5 8130.9 8153.7 8164.4 7188.1 7374.2 7390.7 7420.5 7570.0 7211.8 7308.3 7332.7 7363.4 7432.8 6666.3 6712.9 6829.6 6829.9 6899.0 5081.7 5091.2 5179.4 5195.2 5288.3 4920.3 4977.8 4999.1 5110.9 5135.4 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#4] prototype.html Cycles:180 Average:5845.15 Median:6778.48 stddev:1820.04 (26.9%) stddev-sans-first:1777.83 04:21:41 INFO - PROCESS | 7806 | Values: 352.1 356.4 358.0 362.4 367.8 6436.6 6512.9 6533.0 6552.7 6634.8 6563.8 6581.3 6610.4 6640.9 6643.2 4914.7 4938.1 4940.4 4947.1 4967.0 4943.4 4956.8 4959.2 4961.1 4971.3 4880.0 4887.5 4909.1 4910.0 4921.9 4726.9 4861.9 4928.0 4936.7 4937.9 4204.1 4214.1 4219.3 4221.5 4255.0 6324.6 6330.4 6339.4 6340.4 6347.2 5675.7 5695.1 5728.8 5740.0 5741.5 6844.7 6918.0 6926.4 6930.3 6951.0 4575.6 4725.3 4747.5 4749.4 4754.3 7263.7 7285.6 7305.1 7311.5 7355.9 4795.2 4821.8 4829.4 4833.7 4834.7 4899.2 4899.6 4900.8 4903.3 4904.9 5730.5 5732.1 5733.3 5735.1 5744.9 6880.7 7012.4 7027.2 7052.8 7056.0 1708.0 1714.8 1724.5 1725.8 1730.0 1048.9 1103.5 1113.3 1124.0 1129.9 6762.0 6929.4 6935.7 7011.2 7020.4 7231.7 7257.3 7260.1 7276.8 7303.5 6837.6 6876.9 6878.9 6898.4 6905.4 3842.4 3884.3 3889.3 3912.1 3916.1 7643.5 7647.0 7662.3 7672.6 7675.2 7483.8 7512.7 7521.6 7523.3 7537.6 7612.8 7621.4 7628.0 7628.3 7640.0 6960.7 7233.5 7240.2 7240.9 7258.6 7196.1 7214.2 7224.1 7230.7 7231.7 7509.4 7521.2 7522.2 7533.5 7536.4 4733.3 4785.9 4786.1 4790.1 4802.6 7130.1 7259.1 7275.5 7289.5 7318.6 7012.3 7037.0 7042.4 7051.3 7055.4 6973.3 6989.5 7049.4 7051.7 7073.3 6931.3 6943.2 6955.3 6957.3 6965.0 6948.4 7109.8 7110.0 7124.3 7126.6 6795.0 6906.9 6936.8 6967.4 6972.4 04:21:41 INFO - PROCESS | 7806 | 04:21:41 INFO - PROCESS | 7806 | [#5] yui.html Cycles:180 Average:15940.38 Median:25753.24 stddev:18527.65 (71.9%) stddev-sans-first:18544.81 04:21:41 INFO - PROCESS | 7806 | Values: 816.0 823.2 860.6 896.1 898.4 15011.8 15120.2 15197.4 15737.5 15763.0 14747.7 14750.9 14753.7 14769.7 14809.8 727.4 886.2 893.2 900.8 902.8 892.8 892.9 896.3 896.4 903.4 935.4 948.5 949.6 949.8 950.1 939.7 942.8 945.7 947.5 952.0 686.0 690.3 691.4 691.9 693.3 15427.4 15491.0 15516.6 15556.8 15561.4 13848.5 13921.2 14046.6 14066.3 14110.9 11007.2 11137.7 11166.4 11207.8 11281.9 3962.1 4009.7 4035.1 4054.1 4078.8 55486.0 55625.0 56004.7 56427.7 58581.0 11616.6 11683.4 11842.2 11920.2 12015.6 19899.3 19965.9 19999.4 20002.0 20474.8 8661.2 8832.9 8835.4 8836.6 9057.8 4690.7 4734.6 4879.3 4900.4 5106.8 3326.3 3333.1 3358.5 3367.7 3369.5 642.7 655.5 656.7 671.6 672.6 631.2 642.6 667.1 706.6 728.0 9823.0 10157.7 10252.9 10286.4 10335.8 651.4 717.9 790.8 792.3 808.4 4392.2 4821.9 4857.2 4869.3 4965.5 66077.7 66113.0 66405.7 67214.3 67491.7 56568.4 56773.7 57603.4 58044.4 58089.4 54830.7 54862.7 55429.0 55602.0 55832.4 9361.5 9506.5 9511.6 9535.9 9684.5 39392.4 40176.4 40400.8 41221.0 41231.8 46815.8 52941.5 52985.0 53489.2 54767.5 11058.1 11089.1 11114.7 12739.9 12939.7 13808.7 15104.5 15222.8 15320.8 15744.4 13160.5 13478.3 13981.3 13981.4 14065.2 13863.4 13878.8 13892.7 13919.7 13993.0 12759.8 12837.2 13049.0 13227.5 14374.4 10769.9 10947.7 11132.4 11614.4 11648.4 10464.2 10721.2 11057.4 11078.8 11087.1 04:21:41 INFO - PROCESS | 7806 | -------- Summary: end -------- 04:21:41 INFO - PROCESS | 7806 | 04:21:42 INFO - TEST-INFO | 7806: exit 0 04:21:42 INFO - TEST-OK | dromaeo_css | took 1109410ms 04:21:42 INFO - TEST-START | kraken 04:21:42 INFO - operating with platform_type : linux_ 04:21:42 INFO - Initialising browser for kraken test... 04:21:42 INFO - TEST-INFO | started process 8052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAaY28/profile http://localhost:42775/getInfo.html) 04:21:46 INFO - PROCESS | 8052 | 04:21:46 INFO - PROCESS | 8052 | (process:8131): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:21:46 INFO - PROCESS | 8052 | __metrics Screen width/height:1600/1200 04:21:46 INFO - PROCESS | 8052 | colorDepth:24 04:21:46 INFO - PROCESS | 8052 | Browser inner width/height: 1024/697 04:21:46 INFO - PROCESS | 8052 | __metrics 04:21:47 ERROR - PROCESS | 8052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 04:21:48 INFO - TEST-INFO | 8052: exit 0 04:21:48 INFO - Browser initialized. 04:21:48 INFO - Running cycle 1/1 for kraken test... 04:21:48 INFO - TEST-INFO | started process 8182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAaY28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:50 INFO - PROCESS | 8182 | 04:21:50 INFO - PROCESS | 8182 | (process:8253): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:22:00 INFO - PROCESS | 8182 | RSS: Main: 151617536 04:22:00 INFO - PROCESS | 8182 | 04:22:02 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42775/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:03 INFO - PROCESS | 8182 | RSS: Main: 156766208 04:22:03 INFO - PROCESS | 8182 | 04:22:06 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42775/tests/kraken/driver.html?testName=audio-dft) 04:22:07 INFO - PROCESS | 8182 | RSS: Main: 156844032 04:22:07 INFO - PROCESS | 8182 | 04:22:09 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42775/tests/kraken/driver.html?testName=audio-fft) 04:22:10 INFO - PROCESS | 8182 | RSS: Main: 156778496 04:22:10 INFO - PROCESS | 8182 | 04:22:12 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42775/tests/kraken/driver.html?testName=audio-oscillator) 04:22:13 INFO - PROCESS | 8182 | RSS: Main: 156844032 04:22:13 INFO - PROCESS | 8182 | 04:22:15 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:16 INFO - PROCESS | 8182 | RSS: Main: 156565504 04:22:16 INFO - PROCESS | 8182 | 04:22:19 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42775/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:19 INFO - PROCESS | 8182 | RSS: Main: 157138944 04:22:19 INFO - PROCESS | 8182 | 04:22:22 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42775/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:23 INFO - PROCESS | 8182 | RSS: Main: 156938240 04:22:23 INFO - PROCESS | 8182 | 04:22:26 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42775/tests/kraken/driver.html?testName=json-parse-financial) 04:22:26 INFO - PROCESS | 8182 | RSS: Main: 157237248 04:22:26 INFO - PROCESS | 8182 | 04:22:28 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:29 INFO - PROCESS | 8182 | RSS: Main: 157683712 04:22:29 INFO - PROCESS | 8182 | 04:22:30 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:31 INFO - PROCESS | 8182 | RSS: Main: 157569024 04:22:31 INFO - PROCESS | 8182 | 04:22:33 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:34 INFO - PROCESS | 8182 | RSS: Main: 157798400 04:22:34 INFO - PROCESS | 8182 | 04:22:36 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:37 INFO - PROCESS | 8182 | RSS: Main: 158248960 04:22:37 INFO - PROCESS | 8182 | 04:22:39 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:40 INFO - PROCESS | 8182 | RSS: Main: 158031872 04:22:40 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | Cycle 1(1): loaded http://localhost:42775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42775/tests/kraken/driver.html?testName=ai-astar) 04:22:42 INFO - PROCESS | 8182 | RSS: Main: 158838784 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | __start_tp_report 04:22:42 INFO - PROCESS | 8182 | _x_x_mozilla_page_load 04:22:42 INFO - PROCESS | 8182 | _x_x_mozilla_page_load_details 04:22:42 INFO - PROCESS | 8182 | |i|pagename|runs| 04:22:42 INFO - PROCESS | 8182 | |0;ai-astar;111;111;105;110;111;113;101;109;110;109 04:22:42 INFO - PROCESS | 8182 | |1;audio-beat-detection;160;128;158;192;134;152;154;129;179;130 04:22:42 INFO - PROCESS | 8182 | |2;audio-dft;163;164;163;164;163;165;162;161;162;163 04:22:42 INFO - PROCESS | 8182 | |3;audio-fft;77;75;73;171;74;76;78;74;161;75 04:22:42 INFO - PROCESS | 8182 | |4;audio-oscillator;93;92;154;92;94;92;149;92;94;144 04:22:42 INFO - PROCESS | 8182 | |5;imaging-gaussian-blur;119;117;117;118;117;118;117;118;118;119 04:22:42 INFO - PROCESS | 8182 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;146;145 04:22:42 INFO - PROCESS | 8182 | |7;imaging-desaturate;95;94;94;96;94;95;95;96;97;95 04:22:42 INFO - PROCESS | 8182 | |8;json-parse-financial;57;57;59;59;57;57;60;73;57;57 04:22:42 INFO - PROCESS | 8182 | |9;json-stringify-tinderbox;57;58;58;58;58;57;58;58;58;57 04:22:42 INFO - PROCESS | 8182 | |10;stanford-crypto-aes;72;82;73;74;75;83;76;76;77;74 04:22:42 INFO - PROCESS | 8182 | |11;stanford-crypto-ccm;129;129;125;119;116;117;112;115;138;129 04:22:42 INFO - PROCESS | 8182 | |12;stanford-crypto-pbkdf2;166;168;161;172;166;162;161;160;168;167 04:22:42 INFO - PROCESS | 8182 | |13;stanford-crypto-sha256-iterative;69;73;68;67;66;66;65;67;69;66 04:22:42 INFO - PROCESS | 8182 | __end_tp_report 04:22:42 INFO - PROCESS | 8182 | __start_cc_report 04:22:42 INFO - PROCESS | 8182 | _x_x_mozilla_cycle_collect,854 04:22:42 INFO - PROCESS | 8182 | __end_cc_report 04:22:42 INFO - PROCESS | 8182 | __startTimestamp1465125762505__endTimestamp 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | ------- Summary: start ------- 04:22:42 INFO - PROCESS | 8182 | Number of tests: 14 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.50 (3.2%) stddev-sans-first:3.63 04:22:42 INFO - PROCESS | 8182 | Values: 111.0 111.0 105.0 110.0 111.0 113.0 101.0 109.0 110.0 109.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.00 stddev:21.97 (14.1%) stddev-sans-first:23.09 04:22:42 INFO - PROCESS | 8182 | Values: 160.0 128.0 158.0 192.0 134.0 152.0 154.0 129.0 179.0 130.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 04:22:42 INFO - PROCESS | 8182 | Values: 163.0 164.0 163.0 164.0 163.0 165.0 162.0 161.0 162.0 163.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.36 (51.2%) stddev-sans-first:40.23 04:22:42 INFO - PROCESS | 8182 | Values: 77.0 75.0 73.0 171.0 74.0 76.0 78.0 74.0 161.0 75.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.30 (29.7%) stddev-sans-first:28.29 04:22:42 INFO - PROCESS | 8182 | Values: 93.0 92.0 154.0 92.0 94.0 92.0 149.0 92.0 94.0 144.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 04:22:42 INFO - PROCESS | 8182 | Values: 119.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:22:42 INFO - PROCESS | 8182 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 145.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 04:22:42 INFO - PROCESS | 8182 | Values: 95.0 94.0 94.0 96.0 94.0 95.0 95.0 96.0 97.0 95.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.00 stddev:4.95 (8.5%) stddev-sans-first:5.17 04:22:42 INFO - PROCESS | 8182 | Values: 57.0 57.0 59.0 59.0 57.0 57.0 60.0 73.0 57.0 57.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:22:42 INFO - PROCESS | 8182 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 58.0 58.0 58.0 57.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:3.65 (4.8%) stddev-sans-first:3.54 04:22:42 INFO - PROCESS | 8182 | Values: 72.0 82.0 73.0 74.0 75.0 83.0 76.0 76.0 77.0 74.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:127.00 stddev:8.32 (6.6%) stddev-sans-first:8.53 04:22:42 INFO - PROCESS | 8182 | Values: 129.0 129.0 125.0 119.0 116.0 117.0 112.0 115.0 138.0 129.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.50 stddev:3.93 (2.4%) stddev-sans-first:4.15 04:22:42 INFO - PROCESS | 8182 | Values: 166.0 168.0 161.0 172.0 166.0 162.0 161.0 160.0 168.0 167.0 04:22:42 INFO - PROCESS | 8182 | 04:22:42 INFO - PROCESS | 8182 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.32 (3.4%) stddev-sans-first:2.40 04:22:42 INFO - PROCESS | 8182 | Values: 69.0 73.0 68.0 67.0 66.0 66.0 65.0 67.0 69.0 66.0 04:22:42 INFO - PROCESS | 8182 | -------- Summary: end -------- 04:22:42 INFO - PROCESS | 8182 | 04:22:43 INFO - TEST-INFO | 8182: exit 0 04:22:43 INFO - TEST-OK | kraken | took 60939ms 04:22:43 INFO - SUITE-END | took 1170s 04:22:43 INFO - Completed test suite (00:19:30) 04:22:43 INFO - javascript benchmark 04:22:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.9663103368966, 3416.812075335857, 3443.466262729277, 3461.5846098468187, 3469.0286719718456, 5628.296462942132, 5641.464060914212, 5649.830505084854, 5675.460831221033, 5689.431056894319, 5632.577556683255, 5654.038813401721, 5673.602847800646, 5678.34699009614, 5708.714564271791, 5062.114130027249, 5103.974480127594, 5154.098032844256, 5157.76790044447, 5163.7418129093585, 5086.97456512717, 5191.662541934762, 5286.180642000496, 5291.28567643367, 5297.735113244342, 5195.766190521435, 5237.45006774289, 5269.6311258211945, 5351.7324133793345, 5363.249145119687, 5227.660202086871, 5271.578273738091, 5278.577713782888, 5281.656692314988, 5299.761510732026, 5102.056119617845, 5118.6416950813455, 5174.97412512935, 5180.896382072375, 5209.609279304067, 5473.616846820684, 5584.5253153482, 5591.133374326986, 5594.496495315441, 5670.858228544319, 6018.789342373039, 6063.151158837766, 6066.6663333516635, 6075.27096748393, 6092.756289748405, 6094.664793436359, 6107.664078475682, 6110.5111591073055, 6112.0, 6140.140380346755, 5638.718064096779, 5650.152477128422, 5664.20701101846, 5705.115707065412, 5788.0160372737155, 6229.1590635264565, 6247.094171345129, 6268.216472940882, 6275.623462592259, 6297.433231009231, 5952.285725712942, 5965.522758179335, 6025.879482410327, 6027.6684782336515, 6037.78867739627, 6108.144859719643, 6124.938750612526, 6128.93092736735, 6131.621347939075, 6141.877162456726, 6057.42454466825, 6061.999770037983, 6062.848428789227, 6075.422834830772, 6086.391360863879, 5997.610155339889, 6027.8794424111275, 6051.8487037823525, 6059.303180134253, 6106.206193194945, 4631.282151266559, 4643.141018911512, 4657.883552911204, 4661.463931647836, 4673.018666080094, 4159.604837540489, 4171.937420938689, 4191.7694526801315, 4199.580041995837, 4215.59951804578, 5833.329167145747, 5868.823935281948, 5904.261967254093, 5926.7925622603, 5949.167116603679, 6000.909986350208, 6024.427679370453, 6089.0, 6099.207103076572, 6135.7852475164045, 5823.272090988627, 5848.883022339614, 5858.326292476335, 5859.44335288147, 5861.6189947653265, 4943.0, 5086.160783470686, 5146.022255771466, 5150.562202212854, 5153.819616313411, 6321.810345689637, 6358.77744278948, 6363.013732871413, 6386.329435409308, 6390.84022899422, 6015.879682406415, 6115.960286751174, 6130.141780150693, 6139.201903752483, 6143.539234557516, 6358.523110766619, 6412.9679351602945, 6457.09600655918, 6459.515536334888, 6482.935170648422, 5963.970180149072, 5989.041753319448, 6006.3693312201585, 6030.547708921936, 6032.728527216374, 5916.852078698067, 6097.146399504161, 6117.051856962178, 6121.877562448815, 6134.723937422737, 5859.179714839841, 5863.501602363847, 5866.67733274674, 5879.323877754113, 5901.3213480448585, 5813.244278243801, 5857.5313974881055, 5867.0, 5868.383819699041, 5879.176915231957, 5725.541956643542, 5754.798582049608, 5762.394948530512, 5808.738606762621, 5849.093390524476, 5982.940170598413, 6019.428154325332, 6023.969880150571, 6042.607230530001, 6045.75816967334, 5882.0, 5888.882222355443, 5899.587028907935, 5903.704814759159, 5905.793297234576], "value": 5624.49930794408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.7909058646526, 689.2418339826191, 696.6551556979296, 715.9118140426551, 748.7454265549713, 39039.0, 39707.80146099273, 39932.201355972866, 40054.79972600133, 40055.0, 42877.57122428775, 43662.56337436625, 43712.562874371244, 43770.0, 43838.34242486365, 8676.045634980163, 8867.600957956907, 8867.822643547126, 8872.245859101984, 8891.644334226623, 8960.686375976842, 8979.775505612346, 9081.137291957253, 9105.043970383114, 9128.361014728971, 9023.233025192867, 9156.725298241063, 9169.08309169081, 9174.128457796533, 9181.357304988653, 8761.123887611251, 8782.824343513126, 8787.0334263231, 8806.339524535653, 8816.779580510538, 8990.730278091602, 9098.818023639556, 9120.817583648357, 9124.45253284805, 9157.587908544132, 42662.36006459906, 42842.78578607087, 42883.57116428827, 43155.35266970998, 43482.34776478355, 3500.702440292578, 3510.9824450877836, 3781.0, 3874.1089549403796, 4034.6570541503716, 31896.043118706475, 31990.84004579962, 32105.678943210503, 32115.0, 33015.0, 4540.682152249344, 4566.977165114186, 4614.884627884329, 4625.861224163281, 4672.13565490382, 244645.0, 247162.0, 247473.0, 248036.0, 248283.0, 39441.211175776894, 60926.69536652377, 61297.693511532154, 61543.6922815392, 61911.380886191466, 36018.45972310418, 36111.0, 36197.638023619955, 36209.45685814715, 36273.0, 16526.091064991302, 16568.17159142038, 16652.75020874688, 16686.916565417094, 16749.413770517975, 14088.084274522123, 14108.647283817987, 14109.435622574982, 14166.716665666629, 14210.644733881736, 9035.50304733246, 9144.908550914406, 9165.770855728526, 9283.90716092844, 9356.345055846026, 3478.6869181773254, 3560.092176494977, 3592.946105808415, 3600.71194304455, 3628.691561217326, 1081.3674000709516, 1150.4937827356105, 1167.8802972604865, 1242.9937850310691, 1274.4774642396574, 34205.82897085549, 36565.0, 36568.45147322792, 36798.264034719155, 37018.62981370152, 1254.8305978692943, 1302.5636411802152, 1309.4762095162012, 1332.5402736056046, 1346.6767975685962, 16718.665626687398, 16769.91615041917, 16773.496795096165, 16788.91605541989, 16847.494575162764, 540005.0, 547539.0, 551887.0, 556883.0, 558484.0, 52593.7370313146, 53009.734951324994, 53069.20396193983, 53091.46908530942, 53476.73261633667, 1430.399232322427, 1531.9387224510895, 1540.0836502281124, 1545.2042198267677, 1547.1490680125885, 31628.841855790575, 32128.839355803073, 32151.51772723458, 32268.19329516781, 32315.676843231267, 53176.0, 53590.1961470586, 53625.0, 54023.45976540184, 54056.72971635117, 485261.0, 491339.0, 491340.0, 491832.0, 493608.0, 30427.0, 30434.391312174077, 30837.537436938914, 30864.074077776804, 30905.845470772503, 49506.0, 49766.0, 50122.49877501178, 50275.49724502708, 50513.49486505235, 40935.38596920989, 41733.791331043154, 41816.79091604644, 43062.0, 43279.567204327555, 41334.586654133076, 42547.787261063495, 42646.57353426426, 42700.78649606732, 42798.57201427946, 42767.572324276356, 43227.0, 43416.34875476807, 43744.78127609342, 43803.34294985514, 37054.44418333673, 37165.25669486541, 37471.43792843164, 37700.43449348207, 37989.620103799716, 28595.428091438473, 28809.56785648259, 29108.563371549866, 29220.56169157507, 29465.11604651864], "value": 19559.068141635096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.92441360555085, 420.14156733180994, 430.9612134907858, 434.20757118259166, 442.32545368313316, 18858.33995810147, 19078.713819292687, 19251.903740481313, 19324.806751932476, 19479.41561753148, 18622.255109795628, 18844.905775471103, 19632.60734785307, 20376.694349584766, 20385.694214586754, 5842.094475356316, 5850.414958504158, 5906.940930590682, 5953.434423729739, 6031.306399764039, 5884.058550631899, 5970.910436343436, 6001.189839371695, 6003.279606447232, 6006.519478441714, 5709.71451427429, 5837.416258374171, 5894.587378883459, 5993.4006599340155, 5993.550483713717, 5784.566157538202, 5796.2464879565805, 5803.73883175256, 5822.796202132948, 5830.970845145789, 5161.406438259611, 5194.142966410538, 5210.713410762407, 5349.866253343658, 5353.384360798519, 23122.42193945148, 23382.64926026111, 23879.0, 23923.0, 24025.0, 2566.563684173695, 2597.2597809624167, 2690.233283514209, 2699.9730002699916, 3051.8016328938547, 7655.1962043985695, 7683.654235559413, 11919.0, 12913.096083274175, 15238.466653667068, 2066.2974588639786, 2078.4076538186546, 2163.134746101572, 2195.1877805212175, 2302.1712183613886, 80147.99999999942, 80451.19548804495, 80635.0, 82451.17548824495, 82885.58557207236, 10923.836142457869, 10979.62754655668, 11555.480003399867, 11564.710882227844, 11819.936205741353, 15548.0, 15553.922230389002, 15642.45251416195, 15692.058476491447, 15709.607259818597, 8403.537805420638, 8479.406441549032, 8537.317014638815, 8627.266682332072, 8644.95677521621, 7995.560244186509, 8060.959695201604, 8117.594120294079, 8213.712520061768, 8378.0, 4769.904601907942, 4867.075255701406, 4869.342638743795, 4880.731559764247, 4903.190973489334, 1965.115697935906, 2004.9799502005085, 2014.959700806005, 2059.9588008239753, 2060.701198326234, 968.3995922527937, 1048.1091072588392, 1071.9196060295353, 1136.5510623303749, 1145.66202970124, 19234.71147932782, 19330.4200873974, 19834.107465164103, 19981.800181997995, 20047.456048664822, 1058.8094143054325, 1089.0851684584986, 1109.7225693576606, 1155.0817100405197, 1162.7558212775411, 10903.727406814734, 11137.554497820158, 11229.27009744364, 11300.0, 11312.434378281054, 559178.0, 562973.0, 589250.0, 592684.0, 602136.0, 74681.0, 81920.0, 84367.57816211002, 93450.45846790796, 96817.51591241999, 1091.9890801092047, 1115.4924509348389, 1131.7000994736402, 1135.6649788312468, 1141.463512149272, 17422.31991207923, 17716.0, 17758.11209439549, 17961.550961226072, 18322.358717444826, 40345.39481907833, 40536.3919541213, 40706.796466017484, 41524.3771343424, 41607.79196104, 58623.4137658618, 60328.0, 61001.0, 61088.38911611005, 61369.69315153396, 8886.24466920319, 8889.111088891059, 8968.730938071869, 8974.570055829057, 9046.728598142066, 12050.819237711617, 12726.554570589984, 12888.097833151589, 12926.676833078873, 12960.351982400654, 10262.743431413975, 10793.892061079288, 10980.121590272918, 11079.0, 11154.330740155616, 11417.714557136138, 11438.542458301576, 11588.47851846652, 11594.0, 11925.284482931052, 11132.0, 11202.943985280348, 11280.830787538029, 11342.716432089264, 11407.543698251977, 8734.213920747163, 8789.868151977853, 8928.955355223183, 9034.45793252407, 9094.727158185266, 10777.191710621579, 11110.11119110453, 11149.331040137618, 11221.102311815199, 11352.375619341015], "value": 9511.12263712986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.7568426893831, 1611.3393508661443, 1775.2987569909885, 1832.2945665918617, 1835.1008006077009, 7220.927790722091, 8163.061247956487, 8190.2628763411285, 8334.958325208374, 8339.374546908983, 8233.300169485601, 8272.71045513407, 8322.708705195319, 8327.20891515305, 8338.332933365331, 2334.6498025296214, 2363.291012696184, 2368.786809187173, 2375.8574485530835, 2383.249276477904, 2389.629607410854, 2406.74729153439, 2415.5531226723024, 2420.878956052199, 2431.0761910473993, 2379.773921477457, 2394.521095780851, 2413.9275821725287, 2414.637804329347, 2427.757224277576, 2380.9285721428387, 2382.273406610983, 2404.987975060122, 2418.22616762636, 2419.8790060496904, 2387.9880600596885, 2405.074046492113, 2407.3018824540864, 2417.2506522977933, 2421.2373102472666, 8521.233089022018, 8537.914620853837, 8541.231289183941, 8541.402101852873, 8547.931508561429, 5229.843104706865, 5375.596830237709, 5401.513863752281, 5403.864903377408, 5415.620906536544, 3537.9032499924847, 3547.6984456321243, 3571.8571257149683, 3610.1877077657578, 3631.5279013728045, 1151.936643484608, 1194.3669854976877, 1197.4192516629428, 1198.4007996002, 1237.7153254751368, 12019.399030048462, 12055.095867809949, 12100.273983561014, 12111.394430278451, 12144.939275303655, 4692.296155576691, 4720.457147428021, 4778.160408242851, 4790.113828941588, 4827.951720482821, 10216.438095904648, 10252.6411575596, 10257.846132308021, 10273.845892311621, 10283.331583447052, 5367.838964830983, 5379.865503362447, 5403.891922161613, 5409.215663728737, 5409.513143817076, 4374.365716971021, 4717.8112875485285, 4748.833790817304, 4825.0, 4966.255061740768, 4084.7957602119777, 4139.373863664689, 4217.493900731932, 4228.6617070634275, 4280.122574872206, 1262.0976002158318, 1264.342541878218, 1268.2770820632336, 1270.7776139175608, 1304.0284987684047, 1067.5409573883305, 1067.6209945469402, 1069.2889228663007, 1083.4311986207304, 1084.9349039057681, 5808.593398462067, 5867.647941123546, 5965.105234214902, 5966.671833049137, 6068.089786531968, 484.3630625727228, 485.83724452308167, 490.4751915450505, 492.0257889378978, 498.43427709549195, 4187.1625674865145, 4211.894702632459, 4228.154369126187, 4243.936340954888, 4331.5884990925815, 10052.095311422006, 10216.080552750289, 10314.535845886952, 10391.37651740898, 10399.740006499898, 10233.232507561814, 10247.59009639621, 10251.077403033614, 10263.538140783534, 10269.845952310721, 7795.298423141944, 7859.4891332063235, 7952.801179970431, 7999.120096789348, 8054.798630034296, 5799.594028418139, 5858.297004359504, 5874.941250587611, 5885.470307672159, 5956.612820166675, 9003.414778039407, 9040.502772347583, 9296.535173241176, 9437.339386242897, 9453.574589143642, 9170.862437063315, 9365.157135857806, 9378.343515954091, 9439.669611563562, 9585.952070239604, 6826.317368263134, 7233.963830180815, 7354.448416368687, 7420.851582968203, 7474.925250747423, 8090.919090809017, 8091.514509129235, 8130.918690813016, 8153.673853046049, 8164.387670924586, 7188.101487314086, 7374.225706300761, 7390.704371825067, 7420.5176663516695, 7570.0, 7211.819704507429, 7308.269173082649, 7332.670029848563, 7363.410927125924, 7432.777016689508, 6666.333366663295, 6712.865742685217, 6829.556078854858, 6829.8634027318185, 6898.965505172643, 5081.695098294114, 5091.205827619517, 5179.352580927384, 5195.168772996302, 5288.286081378965, 4920.31115643803, 4977.751112444291, 4999.10016197088, 5110.872228194325, 5135.35808023997], "value": 4542.6666869529545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.1021395441623, 356.4350504450447, 357.98389072491733, 362.4219370104685, 367.82528299057935, 6436.613803171801, 6512.934870651292, 6532.967335163317, 6552.67236638168, 6634.80573496771, 6563.803085907431, 6581.341865813416, 6610.40506354428, 6640.900386494206, 6643.236027856798, 4914.746739581402, 4938.086454006002, 4940.407151141868, 4947.084789313971, 4967.0, 4943.4067911850625, 4956.752162391866, 4959.181735013736, 4961.082199793032, 4971.328870602477, 4879.951200487985, 4887.535684110004, 4909.067277217335, 4910.0, 4921.876953076184, 4726.905461890743, 4861.8784530386665, 4928.0, 4936.728479933602, 4937.901241975158, 4204.07510347723, 4214.093969796509, 4219.282721937278, 4221.514525829538, 4255.0426154115385, 6324.557280990332, 6330.430261276507, 6339.397757213057, 6340.4293613575, 6347.174867267272, 5675.716214189315, 5695.117256825199, 5728.828135155952, 5739.971300143473, 5741.511971482429, 6844.657767111625, 6918.0, 6926.445884329292, 6930.27232140623, 6950.992106144631, 4575.6339492840825, 4725.314829349725, 4747.477777444478, 4749.430068391815, 4754.286856971447, 7263.709451621929, 7285.635718214121, 7305.123385193758, 7311.488195826294, 7355.889661655079, 4795.20879054952, 4821.831235906727, 4829.396325459317, 4833.73414462208, 4834.734089625034, 4899.240617704261, 4899.583535399531, 4900.828471003498, 4903.289023091632, 4904.852854414374, 5730.512906402919, 5732.082866741384, 5733.312002559636, 5735.053716136791, 5744.942550574524, 6880.69036893341, 7012.403945664676, 7027.191872934575, 7052.788416347517, 7056.0, 1707.9743803842953, 1714.8285171482753, 1724.4912750738563, 1725.8360455756683, 1729.982700172982, 1048.8793788714395, 1103.5254840418536, 1113.3486910157649, 1123.9606613768478, 1129.8757136714955, 6761.966190169116, 6929.44564434844, 6935.653217339213, 7011.228764835864, 7020.403265722471, 7231.710731570678, 7257.346838784535, 7260.056192694916, 7276.8180795479475, 7303.525270857377, 6837.555558888656, 6876.931230687629, 6878.8624227516175, 6898.413634840995, 6905.37851593359, 3842.4044273137706, 3884.2814079395403, 3889.2999260132883, 3912.1002169501176, 3916.060145565044, 7643.541387516767, 7646.9617651912495, 7662.3487003604205, 7672.616369181518, 7675.15573286938, 7483.775486735407, 7512.699492020367, 7521.586312752742, 7523.285287897641, 7537.585432801139, 7612.8477430452185, 7621.428392870557, 7627.999999999889, 7628.313451789366, 7639.961800190964, 6960.686769095301, 7233.529820561646, 7240.239774823778, 7240.8913866290995, 7258.564486130849, 7196.10048743907, 7214.170370407261, 7224.13310402734, 7230.674619642234, 7231.746888858865, 7509.361704254981, 7521.172671006294, 7522.172561018174, 7533.472656913963, 7536.359409450258, 4733.290006499053, 4785.928211076906, 4786.090642777861, 4790.113828941657, 4802.615790736802, 7130.144382674112, 7259.092613423322, 7275.454340924558, 7289.489735718449, 7318.597477138808, 7012.298770122947, 7037.0, 7042.436605071684, 7051.330123638246, 7055.3650171484815, 6973.3375329343635, 6989.47578931572, 7049.400800931979, 7051.717931282691, 7073.292670732885, 6931.272216417406, 6943.236244013256, 6955.339242771928, 6957.304269573002, 6964.965175174092, 6948.374646281859, 7109.822254443473, 7109.964450177716, 7124.323189297009, 7126.608036558039, 6795.0, 6906.8618627626165, 6936.7572134975035, 6967.442604591519, 6972.4073453757], "value": 5243.718765527686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.987760183597, 823.2467292427428, 860.5869182792255, 896.0949441064523, 898.4160295807724, 15011.849881501183, 15120.168390738505, 15197.392104315828, 15737.527874163765, 15763.0, 14747.705045899102, 14750.926245368784, 14753.704925901475, 14769.704605907875, 14809.777853332182, 727.37445796615, 886.1979908183073, 893.1515060692336, 900.8153328567628, 902.8104098139365, 892.7768057985504, 892.9062448442918, 896.3008853094564, 896.4307664632939, 903.4172958441801, 935.3732998890725, 948.5115165689675, 949.6296444386695, 949.8480243161096, 950.0974074629096, 939.6523286384047, 942.7643089227693, 945.7257395355339, 947.4599478297373, 951.9904800952006, 686.0292685849518, 690.2579726793666, 691.4192078653905, 691.872003679321, 693.2789898505548, 15427.3829046838, 15491.0, 15516.61208469786, 15556.766648500281, 15561.443855614349, 13848.515301964484, 13921.23433211173, 14046.578602641937, 14066.2966851657, 14110.85889141116, 11007.229493935427, 11137.721556961142, 11166.441677916153, 11207.831882521768, 11281.943590281997, 3962.0689138052535, 4009.7393669411395, 4035.1122752994293, 4054.0675644601906, 4078.8164532595806, 55486.0, 55625.0, 56004.71997639986, 56427.71786141125, 58581.0, 11616.593419230287, 11683.415829208505, 11842.171048026728, 11920.165588408729, 12015.639530814089, 19899.303524376577, 19965.900170499055, 19999.400017999484, 20002.0, 20474.79525204729, 8661.220490155916, 8832.8675069874, 8835.425697329652, 8836.55817209137, 9057.81884362309, 4690.718556886598, 4734.573888350065, 4879.316895634614, 4900.411950565955, 5106.846794596168, 3326.334733053399, 3333.1333853198344, 3358.462645976681, 3367.696907278357, 3369.4945758136478, 642.7461152844601, 655.4887187993373, 656.7208936202095, 671.6104659297596, 672.5998031171445, 631.2298995225817, 642.6208536963121, 667.1293961380348, 706.5654622407183, 728.049697305426, 9822.974841166539, 10157.746056348651, 10252.948735256276, 10286.434246116385, 10335.793284134275, 651.4072194303257, 717.8851383778571, 790.7864876483433, 792.2671528835918, 808.3533173461208, 4392.1874453226255, 4821.879453013633, 4857.1742803723455, 4869.318295438641, 4965.453800081988, 66077.66961165164, 66113.0, 66405.66797165983, 67214.3278567208, 67491.66254168795, 56568.43431565714, 56773.716131419904, 57603.423965760645, 58044.4195558039, 58089.41910580925, 54830.725846370515, 54862.72568637131, 55429.0, 55602.0, 55832.441675583534, 9361.485118318558, 9506.524673766422, 9511.619535218513, 9535.856962145712, 9684.46735429558, 39392.40911386389, 40176.397354040295, 40400.79799601101, 41221.0, 41231.7938410306, 46815.765921170176, 52941.47058529365, 52985.0, 53489.19766203432, 54767.45232547623, 11058.060064894575, 11089.057430118208, 11114.722131946766, 12739.936300318439, 12939.741205176033, 13808.723825523633, 15104.54686359411, 15222.771658425354, 15320.846791531942, 15744.448944286894, 13160.47358105665, 13478.258695771827, 13981.300934953008, 13981.44074237019, 14065.226412547, 13863.376148073563, 13878.791818122534, 13892.652683682989, 13919.721605568035, 13993.0, 12759.808602870778, 12837.165584236995, 13049.0, 13227.470901163846, 14374.425022999381, 10769.892301076889, 10947.726306842393, 11132.443377831238, 11614.419279036183, 11648.41757912118, 10464.215183861088, 10721.195910306915, 11057.447127643425, 11078.833817492905, 11087.113030957666], "value": 7183.186474758185, "unit": "score"}], "name": "dromaeo_css", "value": 7507.488577790681, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 110.0, 111.0, 113.0, 101.0, 109.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 158.0, 192.0, 134.0, 152.0, 154.0, 129.0, 179.0, 130.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 163.0, 165.0, 162.0, 161.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 73.0, 171.0, 74.0, 76.0, 78.0, 74.0, 161.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 92.0, 94.0, 92.0, 149.0, 92.0, 94.0, 144.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 96.0, 94.0, 95.0, 95.0, 96.0, 97.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 59.0, 57.0, 57.0, 60.0, 73.0, 57.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 73.0, 74.0, 75.0, 83.0, 76.0, 76.0, 77.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 125.0, 119.0, 116.0, 117.0, 112.0, 115.0, 138.0, 129.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 161.0, 172.0, 166.0, 162.0, 161.0, 160.0, 168.0, 167.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 67.0, 66.0, 66.0, 65.0, 67.0, 69.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1534.4, "alertThreshold": 2.0}]} 04:22:43 INFO - Return code: 0 04:22:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:22:43 ERROR - # TBPL SUCCESS # 04:22:43 INFO - Running post-action listener: _resource_record_post_action 04:22:43 INFO - Running post-run listener: _resource_record_post_run 04:22:44 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 511225856; Read time: 0; Write time: 481416 04:22:44 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 262033408; Read time: 0; Write time: 335308 04:22:44 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 248594432; Read time: 0; Write time: 146108 04:22:44 INFO - Running post-run listener: _upload_blobber_files 04:22:44 INFO - Blob upload gear active. 04:22:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:44 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 04:22:44 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:22:44 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:22:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:46 INFO - (blobuploader) - INFO - Done attempting. 04:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:47 INFO - (blobuploader) - INFO - Done attempting. 04:22:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:47 INFO - Return code: 0 04:22:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12826911e0c9a3a679ee44dc59b56692299652dcbf8051da52faf979b9e572b053bcdc2ddf9c84d0ca706fffda0e643894095b0ee64585d057733c91f8b0e0da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a82a9c54eaf720751bcbe53e317bc010437aa5cb72c014ba52f9e20ba3d4dade8fdfbb80e361c756010d8dc02376f4d90a9370ce0fadf2de74ff825264171d75"} 04:22:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:47 INFO - Contents: 04:22:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12826911e0c9a3a679ee44dc59b56692299652dcbf8051da52faf979b9e572b053bcdc2ddf9c84d0ca706fffda0e643894095b0ee64585d057733c91f8b0e0da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a82a9c54eaf720751bcbe53e317bc010437aa5cb72c014ba52f9e20ba3d4dade8fdfbb80e361c756010d8dc02376f4d90a9370ce0fadf2de74ff825264171d75"} 04:22:47 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:47 INFO - Copying logs to upload dir... 04:22:47 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.264223 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-06-05 04:22:45.908074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:22:45.912312) ========= 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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 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/Mozilla-Aurora/sha512/12826911e0c9a3a679ee44dc59b56692299652dcbf8051da52faf979b9e572b053bcdc2ddf9c84d0ca706fffda0e643894095b0ee64585d057733c91f8b0e0da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a82a9c54eaf720751bcbe53e317bc010437aa5cb72c014ba52f9e20ba3d4dade8fdfbb80e361c756010d8dc02376f4d90a9370ce0fadf2de74ff825264171d75"} build_url:https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/fFGtanb0R1WyXvwUIY2xow/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12826911e0c9a3a679ee44dc59b56692299652dcbf8051da52faf979b9e572b053bcdc2ddf9c84d0ca706fffda0e643894095b0ee64585d057733c91f8b0e0da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a82a9c54eaf720751bcbe53e317bc010437aa5cb72c014ba52f9e20ba3d4dade8fdfbb80e361c756010d8dc02376f4d90a9370ce0fadf2de74ff825264171d75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:22:45.942076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:22:45.942600) ========= 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=574dc5aafe09851ec43d388c000001b6-1465124431.995022-1034813287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:22:46.024907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:22:46.025274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:22:46.025590) ========= ========= Total master_lag: 0.17 =========