builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1462452994.4 results: success (0) buildid: 20160505030327 builduid: ca051577918442339c331ae12a805704 revision: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.402510) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.402965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.403237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.450116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.450448) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 05:56:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-05-05 05:56:34 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.586972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.587319) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017642 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.640465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:34.640794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b --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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 05:56:34,710 truncating revision to first 12 chars 2016-05-05 05:56:34,710 Setting DEBUG logging. 2016-05-05 05:56:34,710 attempt 1/10 2016-05-05 05:56:34,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/369a5ee3a288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 05:56:35,073 unpacking tar archive at: mozilla-central-369a5ee3a288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.604365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.604682) ========= script_repo_revision: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.605061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.605323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 05:56:35.615055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-05 05:56:35.615394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:35 INFO - MultiFileLogger online at 20160505 05:56:35 in /builds/slave/test 05:56:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:56:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:35 INFO - {'append_to_log': False, 05:56:35 INFO - 'base_work_dir': '/builds/slave/test', 05:56:35 INFO - 'blob_upload_branch': 'Firefox', 05:56:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:35 INFO - 'branch': 'Firefox', 05:56:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:35 INFO - 'config_files': ('talos/linux_config.py',), 05:56:35 INFO - 'default_actions': ('clobber', 05:56:35 INFO - 'read-buildbot-config', 05:56:35 INFO - 'download-and-extract', 05:56:35 INFO - 'populate-webroot', 05:56:35 INFO - 'create-virtualenv', 05:56:35 INFO - 'install', 05:56:35 INFO - 'run-tests'), 05:56:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:35 INFO - 'download_minidump_stackwalk': True, 05:56:35 INFO - 'download_symbols': 'ondemand', 05:56:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:35 INFO - 'installer_path': 'installer.exe', 05:56:35 INFO - 'log_level': 'info', 05:56:35 INFO - 'log_name': 'talos', 05:56:35 INFO - 'log_to_console': True, 05:56:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:35 INFO - 'opt_config_files': (), 05:56:35 INFO - 'pip_index': False, 05:56:35 INFO - 'sps_profile': False, 05:56:35 INFO - 'sps_profile_interval': 0, 05:56:35 INFO - 'suite': 'dromaeojs-e10s', 05:56:35 INFO - 'system_bits': '32', 05:56:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:35 INFO - 'title': 'talos-linux64-ix-034', 05:56:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:35 INFO - 'use_talos_json': True, 05:56:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:35 INFO - 'work_dir': 'build'} 05:56:35 INFO - ##### 05:56:35 INFO - ##### Running clobber step. 05:56:35 INFO - ##### 05:56:35 INFO - Running pre-action listener: _resource_record_pre_action 05:56:35 INFO - Running main action method: clobber 05:56:35 INFO - rmtree: /builds/slave/test/build 05:56:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:36 INFO - Running post-action listener: _resource_record_post_action 05:56:36 INFO - ##### 05:56:36 INFO - ##### Running read-buildbot-config step. 05:56:36 INFO - ##### 05:56:36 INFO - Running pre-action listener: _resource_record_pre_action 05:56:36 INFO - Running main action method: read_buildbot_config 05:56:36 INFO - Using buildbot properties: 05:56:36 INFO - { 05:56:36 INFO - "project": "", 05:56:36 INFO - "product": "firefox", 05:56:36 INFO - "script_repo_revision": "production", 05:56:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:56:36 INFO - "repository": "", 05:56:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:56:36 INFO - "buildid": "20160505030327", 05:56:36 INFO - "stage_platform": "linux64-pgo", 05:56:36 INFO - "basedir": "/builds/slave/test", 05:56:36 INFO - "nightly_build": "True", 05:56:36 INFO - "buildnumber": 21, 05:56:36 INFO - "slavename": "talos-linux64-ix-034", 05:56:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:56:36 INFO - "platform": "ubuntu64_hw", 05:56:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:56:36 INFO - "branch": "mozilla-central", 05:56:36 INFO - "repo_path": "mozilla-central", 05:56:36 INFO - "revision": "369a5ee3a2880a4a98df3a00bf3db8d8f36b181b", 05:56:36 INFO - "pgo_build": "True", 05:56:36 INFO - "builduid": "ca051577918442339c331ae12a805704", 05:56:36 INFO - "slavebuilddir": "test" 05:56:36 INFO - } 05:56:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:56:36 INFO - Running post-action listener: _resource_record_post_action 05:56:36 INFO - ##### 05:56:36 INFO - ##### Running download-and-extract step. 05:56:36 INFO - ##### 05:56:36 INFO - Running pre-action listener: _resource_record_pre_action 05:56:36 INFO - Running main action method: download_and_extract 05:56:36 INFO - mkdir: /builds/slave/test/build/tests 05:56:36 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')]} 05:56:36 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:56:44 INFO - Downloaded 1361 bytes. 05:56:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:44 INFO - Using the following test package requirements: 05:56:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:56:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'jsshell-linux-x86_64.zip'], 05:56:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:56:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:56:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:56:44 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:53 INFO - Downloaded 23879852 bytes. 05:56:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:55 INFO - Return code: 0 05:56:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:55 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')]} 05:56:55 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:56 INFO - Downloaded 23879852 bytes. 05:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:57 INFO - Return code: 0 05:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:56:57 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:58 INFO - Downloaded 10840152 bytes. 05:56:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:56:58 INFO - Return code: 0 05:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:56:58 INFO - https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:57:00 INFO - Downloaded 58380512 bytes. 05:57:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:00 INFO - mkdir: /builds/slave/test/properties 05:57:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:00 INFO - Contents: 05:57:00 INFO - build_url:https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:57:01 INFO - Running post-action listener: _resource_record_post_action 05:57:01 INFO - Running post-action listener: set_extra_try_arguments 05:57:01 INFO - ##### 05:57:01 INFO - ##### Running populate-webroot step. 05:57:01 INFO - ##### 05:57:01 INFO - Running pre-action listener: _resource_record_pre_action 05:57:01 INFO - Running main action method: populate_webroot 05:57:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:57:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:57:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:57:01 INFO - '--tppagecycles', 05:57:01 INFO - '7'], 05:57:01 INFO - 'tests': ['tsvgm']}}, 05:57:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['damp', 'tps']}, 05:57:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'tests': ['damp', 'tps']}, 05:57:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['dromaeo_dom']}, 05:57:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['a11yr', 05:57:01 INFO - 'ts_paint', 05:57:01 INFO - 'tpaint', 05:57:01 INFO - 'sessionrestore', 05:57:01 INFO - 'sessionrestore_no_auto_restore', 05:57:01 INFO - 'tabpaint']}, 05:57:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['tsvgx', 05:57:01 INFO - 'tsvgr_opacity', 05:57:01 INFO - 'tart', 05:57:01 INFO - 'tscrollx', 05:57:01 INFO - 'cart']}, 05:57:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:01 INFO - 'tsvgr_opacity', 05:57:01 INFO - 'tart', 05:57:01 INFO - 'tscrollx', 05:57:01 INFO - 'cart']}, 05:57:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'talos_options': ['--disable-e10s'], 05:57:01 INFO - 'tests': ['tp5o']}, 05:57:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'tests': ['tp5o']}, 05:57:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'talos_options': ['--disable-e10s', 05:57:01 INFO - '--xperf_path', 05:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:01 INFO - 'tests': ['tp5n']}, 05:57:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:01 INFO - 'talos_options': ['--xperf_path', 05:57:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:01 INFO - 'tests': ['tp5n']}}, 05:57:01 INFO - 'talos.zip': {'path': '', 05:57:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:57:01 INFO - Running post-action listener: _resource_record_post_action 05:57:01 INFO - ##### 05:57:01 INFO - ##### Running create-virtualenv step. 05:57:01 INFO - ##### 05:57:01 INFO - Running pre-action listener: _resource_record_pre_action 05:57:01 INFO - Running main action method: create_virtualenv 05:57:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:01 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 05:57:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:57:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:01 INFO - Using real prefix '/usr' 05:57:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:03 INFO - Installing pip.................done. 05:57:03 INFO - Return code: 0 05:57:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:03 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:03 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 05:57:03 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 05:57:03 INFO - Using env: {'DISPLAY': ':0', 05:57:03 INFO - 'HOME': '/home/cltbld', 05:57:03 INFO - 'LANG': 'en_US.UTF-8', 05:57:03 INFO - 'LANGUAGE': 'en_US:en', 05:57:03 INFO - 'LOGNAME': 'cltbld', 05:57:03 INFO - 'MAIL': '/var/mail/cltbld', 05:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:03 INFO - 'MOZ_NO_REMOTE': '1', 05:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:03 INFO - 'NO_EM_RESTART': '1', 05:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:03 INFO - 'PWD': '/builds/slave/test', 05:57:03 INFO - 'SHELL': '/bin/bash', 05:57:03 INFO - 'SHLVL': '1', 05:57:03 INFO - 'TERM': 'linux', 05:57:03 INFO - 'TMOUT': '86400', 05:57:03 INFO - 'USER': 'cltbld', 05:57:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:03 INFO - '_': '/tools/buildbot/bin/python'} 05:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:04 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 05:57:04 INFO - Cleaning up... 05:57:04 INFO - Return code: 0 05:57:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:57:04 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')]} 05:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:04 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')]} 05:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:04 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:04 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 05:57:04 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 05:57:04 INFO - Using env: {'DISPLAY': ':0', 05:57:04 INFO - 'HOME': '/home/cltbld', 05:57:04 INFO - 'LANG': 'en_US.UTF-8', 05:57:04 INFO - 'LANGUAGE': 'en_US:en', 05:57:04 INFO - 'LOGNAME': 'cltbld', 05:57:04 INFO - 'MAIL': '/var/mail/cltbld', 05:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:04 INFO - 'MOZ_NO_REMOTE': '1', 05:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:04 INFO - 'NO_EM_RESTART': '1', 05:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:04 INFO - 'PWD': '/builds/slave/test', 05:57:04 INFO - 'SHELL': '/bin/bash', 05:57:04 INFO - 'SHLVL': '1', 05:57:04 INFO - 'TERM': 'linux', 05:57:04 INFO - 'TMOUT': '86400', 05:57:04 INFO - 'USER': 'cltbld', 05:57:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:04 INFO - '_': '/tools/buildbot/bin/python'} 05:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:04 INFO - Downloading/unpacking psutil>=0.7.1 05:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:06 INFO - Installing collected packages: psutil 05:57:06 INFO - Running setup.py install for psutil 05:57:06 INFO - building 'psutil._psutil_linux' extension 05:57:06 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 05:57:06 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 05:57:06 INFO - building 'psutil._psutil_posix' extension 05:57:06 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 05:57:06 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 05:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:06 INFO - Successfully installed psutil 05:57:06 INFO - Cleaning up... 05:57:06 INFO - Return code: 0 05:57:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57:06 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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:06 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:06 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 05:57:06 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 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:07 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 05:57:07 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 05:57:07 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 05:57:07 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 05:57:07 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 05:57:07 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 05:57:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:09 INFO - Installing collected packages: mozsystemmonitor 05:57:09 INFO - Running setup.py install for mozsystemmonitor 05:57:09 INFO - Successfully installed mozsystemmonitor 05:57:09 INFO - Cleaning up... 05:57:09 INFO - Return code: 0 05:57:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:09 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')]} 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 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')]} 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:09 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:09 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 05:57:09 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 05:57:09 INFO - Using env: {'DISPLAY': ':0', 05:57:09 INFO - 'HOME': '/home/cltbld', 05:57:09 INFO - 'LANG': 'en_US.UTF-8', 05:57:09 INFO - 'LANGUAGE': 'en_US:en', 05:57:09 INFO - 'LOGNAME': 'cltbld', 05:57:09 INFO - 'MAIL': '/var/mail/cltbld', 05:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:09 INFO - 'MOZ_NO_REMOTE': '1', 05:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:09 INFO - 'NO_EM_RESTART': '1', 05:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:09 INFO - 'PWD': '/builds/slave/test', 05:57:09 INFO - 'SHELL': '/bin/bash', 05:57:09 INFO - 'SHLVL': '1', 05:57:09 INFO - 'TERM': 'linux', 05:57:09 INFO - 'TMOUT': '86400', 05:57:09 INFO - 'USER': 'cltbld', 05:57:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:09 INFO - '_': '/tools/buildbot/bin/python'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 INFO - Downloading docopt-0.6.1.tar.gz 05:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:12 INFO - Running setup.py install for blobuploader 05:57:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:12 INFO - Running setup.py install for requests 05:57:12 INFO - Running setup.py install for docopt 05:57:12 INFO - Successfully installed blobuploader requests docopt 05:57:12 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:12 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 05:57:12 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 05:57:12 INFO - Using env: {'DISPLAY': ':0', 05:57:12 INFO - 'HOME': '/home/cltbld', 05:57:12 INFO - 'LANG': 'en_US.UTF-8', 05:57:12 INFO - 'LANGUAGE': 'en_US:en', 05:57:12 INFO - 'LOGNAME': 'cltbld', 05:57:12 INFO - 'MAIL': '/var/mail/cltbld', 05:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:12 INFO - 'MOZ_NO_REMOTE': '1', 05:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:12 INFO - 'NO_EM_RESTART': '1', 05:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:12 INFO - 'PWD': '/builds/slave/test', 05:57:12 INFO - 'SHELL': '/bin/bash', 05:57:12 INFO - 'SHLVL': '1', 05:57:12 INFO - 'TERM': 'linux', 05:57:12 INFO - 'TMOUT': '86400', 05:57:12 INFO - 'USER': 'cltbld', 05:57:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:12 INFO - '_': '/tools/buildbot/bin/python'} 05:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:12 INFO - Running setup.py (path:/tmp/pip-2F3sW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:12 INFO - Running setup.py (path:/tmp/pip-WTzDlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:12 INFO - Running setup.py (path:/tmp/pip-a4NGyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Running setup.py (path:/tmp/pip-RSWPyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Running setup.py (path:/tmp/pip-feGAzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Running setup.py (path:/tmp/pip-VPYhZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:13 INFO - Running setup.py (path:/tmp/pip-750MI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:13 INFO - Running setup.py (path:/tmp/pip-gHW8xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:13 INFO - Running setup.py (path:/tmp/pip-bFavnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:13 INFO - Running setup.py (path:/tmp/pip-j5s96m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:13 INFO - Running setup.py (path:/tmp/pip-EasSB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:13 INFO - Running setup.py (path:/tmp/pip-pjTZac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:13 INFO - Running setup.py (path:/tmp/pip-yTrah4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:13 INFO - Running setup.py (path:/tmp/pip-Ljpcpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:13 INFO - Running setup.py (path:/tmp/pip-Nqd0LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:13 INFO - Running setup.py (path:/tmp/pip-hSHpMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:13 INFO - Running setup.py (path:/tmp/pip-txS_Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:14 INFO - Running setup.py install for manifestparser 05:57:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Running setup.py install for mozcrash 05:57:14 INFO - Running setup.py install for mozdebug 05:57:14 INFO - Running setup.py install for mozdevice 05:57:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Running setup.py install for mozfile 05:57:14 INFO - Running setup.py install for mozhttpd 05:57:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Running setup.py install for mozinfo 05:57:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Running setup.py install for mozInstall 05:57:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:14 INFO - Running setup.py install for mozleak 05:57:14 INFO - Running setup.py install for mozlog 05:57:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for moznetwork 05:57:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for mozprocess 05:57:15 INFO - Running setup.py install for mozprofile 05:57:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for mozrunner 05:57:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for mozscreenshot 05:57:15 INFO - Running setup.py install for moztest 05:57:15 INFO - Running setup.py install for mozversion 05:57:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:15 INFO - Cleaning up... 05:57:15 INFO - Return code: 0 05:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:15 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')]} 05:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 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')]} 05:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:15 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 05:57:15 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 05:57:15 INFO - Using env: {'DISPLAY': ':0', 05:57:15 INFO - 'HOME': '/home/cltbld', 05:57:15 INFO - 'LANG': 'en_US.UTF-8', 05:57:15 INFO - 'LANGUAGE': 'en_US:en', 05:57:15 INFO - 'LOGNAME': 'cltbld', 05:57:15 INFO - 'MAIL': '/var/mail/cltbld', 05:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:15 INFO - 'MOZ_NO_REMOTE': '1', 05:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:15 INFO - 'NO_EM_RESTART': '1', 05:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:15 INFO - 'PWD': '/builds/slave/test', 05:57:15 INFO - 'SHELL': '/bin/bash', 05:57:15 INFO - 'SHLVL': '1', 05:57:15 INFO - 'TERM': 'linux', 05:57:15 INFO - 'TMOUT': '86400', 05:57:15 INFO - 'USER': 'cltbld', 05:57:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:15 INFO - '_': '/tools/buildbot/bin/python'} 05:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:16 INFO - Running setup.py (path:/tmp/pip-6zeRxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:16 INFO - Running setup.py (path:/tmp/pip-cgNNj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:16 INFO - Running setup.py (path:/tmp/pip-8WC9r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:16 INFO - Running setup.py (path:/tmp/pip-jm7p3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:16 INFO - Running setup.py (path:/tmp/pip-8jsM5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:16 INFO - Running setup.py (path:/tmp/pip-QtLmEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:16 INFO - Running setup.py (path:/tmp/pip-ZJBoRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:16 INFO - Running setup.py (path:/tmp/pip-TO8ybm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:16 INFO - Running setup.py (path:/tmp/pip-7FeYge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:16 INFO - Running setup.py (path:/tmp/pip-gOVUD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:16 INFO - Running setup.py (path:/tmp/pip-cxke6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:16 INFO - Running setup.py (path:/tmp/pip-N4e6ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:16 INFO - Running setup.py (path:/tmp/pip-5P5yjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:16 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)) 05:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:16 INFO - Running setup.py (path:/tmp/pip-99OJPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:17 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)) 05:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:17 INFO - Running setup.py (path:/tmp/pip-95sCw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:17 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)) 05:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:17 INFO - Running setup.py (path:/tmp/pip-MwEBpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:17 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)) 05:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:17 INFO - Running setup.py (path:/tmp/pip-5oJ1Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 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)) 05:57:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:19 INFO - Downloading blessings-1.6.tar.gz 05:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:19 INFO - Installing collected packages: blessings 05:57:19 INFO - Running setup.py install for blessings 05:57:19 INFO - Successfully installed blessings 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:19 INFO - Reading from file tmpfile_stdout 05:57:19 INFO - Current package versions: 05:57:19 INFO - argparse == 1.2.1 05:57:19 INFO - blessings == 1.6 05:57:19 INFO - blobuploader == 1.2.4 05:57:19 INFO - docopt == 0.6.1 05:57:19 INFO - manifestparser == 1.1 05:57:19 INFO - mozInstall == 1.12 05:57:19 INFO - mozcrash == 0.17 05:57:19 INFO - mozdebug == 0.1 05:57:19 INFO - mozdevice == 0.48 05:57:19 INFO - mozfile == 1.2 05:57:19 INFO - mozhttpd == 0.7 05:57:19 INFO - mozinfo == 0.9 05:57:19 INFO - mozleak == 0.1 05:57:19 INFO - mozlog == 3.1 05:57:19 INFO - moznetwork == 0.27 05:57:19 INFO - mozprocess == 0.22 05:57:19 INFO - mozprofile == 0.28 05:57:19 INFO - mozrunner == 6.11 05:57:19 INFO - mozscreenshot == 0.1 05:57:19 INFO - mozsystemmonitor == 0.0 05:57:19 INFO - moztest == 0.7 05:57:19 INFO - mozversion == 1.4 05:57:19 INFO - psutil == 3.1.1 05:57:19 INFO - requests == 1.2.3 05:57:19 INFO - wsgiref == 0.1.2 05:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:19 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')]} 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 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')]} 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:19 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 05:57:19 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 05:57:19 INFO - Using env: {'DISPLAY': ':0', 05:57:19 INFO - 'HOME': '/home/cltbld', 05:57:19 INFO - 'LANG': 'en_US.UTF-8', 05:57:19 INFO - 'LANGUAGE': 'en_US:en', 05:57:19 INFO - 'LOGNAME': 'cltbld', 05:57:19 INFO - 'MAIL': '/var/mail/cltbld', 05:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:19 INFO - 'MOZ_NO_REMOTE': '1', 05:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:19 INFO - 'NO_EM_RESTART': '1', 05:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:19 INFO - 'PWD': '/builds/slave/test', 05:57:19 INFO - 'SHELL': '/bin/bash', 05:57:19 INFO - 'SHLVL': '1', 05:57:19 INFO - 'TERM': 'linux', 05:57:19 INFO - 'TMOUT': '86400', 05:57:19 INFO - 'USER': 'cltbld', 05:57:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:19 INFO - '_': '/tools/buildbot/bin/python'} 05:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:19 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')]} 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 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')]} 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:19 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 05:57:19 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 05:57:19 INFO - Using env: {'DISPLAY': ':0', 05:57:19 INFO - 'HOME': '/home/cltbld', 05:57:19 INFO - 'LANG': 'en_US.UTF-8', 05:57:19 INFO - 'LANGUAGE': 'en_US:en', 05:57:19 INFO - 'LOGNAME': 'cltbld', 05:57:19 INFO - 'MAIL': '/var/mail/cltbld', 05:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:19 INFO - 'MOZ_NO_REMOTE': '1', 05:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:19 INFO - 'NO_EM_RESTART': '1', 05:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:19 INFO - 'PWD': '/builds/slave/test', 05:57:19 INFO - 'SHELL': '/bin/bash', 05:57:19 INFO - 'SHLVL': '1', 05:57:19 INFO - 'TERM': 'linux', 05:57:19 INFO - 'TMOUT': '86400', 05:57:19 INFO - 'USER': 'cltbld', 05:57:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:19 INFO - '_': '/tools/buildbot/bin/python'} 05:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:19 INFO - Downloading/unpacking jsonschema 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:22 INFO - warning: no files found matching '*.txt' 05:57:22 INFO - no previously-included directories found matching 'build' 05:57:22 INFO - no previously-included directories found matching 'dist' 05:57:22 INFO - no previously-included directories found matching '.git*' 05:57:22 INFO - Installing collected packages: jsonschema, functools32 05:57:22 INFO - Running setup.py install for functools32 05:57:22 INFO - warning: no files found matching '*.txt' 05:57:22 INFO - no previously-included directories found matching 'build' 05:57:22 INFO - no previously-included directories found matching 'dist' 05:57:22 INFO - no previously-included directories found matching '.git*' 05:57:22 INFO - Successfully installed jsonschema functools32 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 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 0x7f07d1730f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14977d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', '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 05:57:22 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 05:57:22 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 05:57:22 INFO - Using env: {'DISPLAY': ':0', 05:57:22 INFO - 'HOME': '/home/cltbld', 05:57:22 INFO - 'LANG': 'en_US.UTF-8', 05:57:22 INFO - 'LANGUAGE': 'en_US:en', 05:57:22 INFO - 'LOGNAME': 'cltbld', 05:57:22 INFO - 'MAIL': '/var/mail/cltbld', 05:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:22 INFO - 'MOZ_NO_REMOTE': '1', 05:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:22 INFO - 'NO_EM_RESTART': '1', 05:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:22 INFO - 'PWD': '/builds/slave/test', 05:57:22 INFO - 'SHELL': '/bin/bash', 05:57:22 INFO - 'SHLVL': '1', 05:57:22 INFO - 'TERM': 'linux', 05:57:22 INFO - 'TMOUT': '86400', 05:57:22 INFO - 'USER': 'cltbld', 05:57:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:22 INFO - '_': '/tools/buildbot/bin/python'} 05:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:22 INFO - Downloading/unpacking flake8 05:57:22 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 05:57:22 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 05:57:22 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 05:57:22 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 05:57:22 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 05:57:22 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 05:57:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:25 INFO - no previously-included directories found matching 'docs/_build' 05:57:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:25 INFO - Running setup.py install for pep8 05:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:25 INFO - no previously-included directories found matching 'docs/_build' 05:57:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:25 INFO - Cleaning up... 05:57:25 INFO - Return code: 0 05:57:25 INFO - Running post-action listener: _resource_record_post_action 05:57:25 INFO - Running post-action listener: _start_resource_monitoring 05:57:25 INFO - Starting resource monitoring. 05:57:25 INFO - ##### 05:57:25 INFO - ##### Running install step. 05:57:25 INFO - ##### 05:57:25 INFO - Running pre-action listener: _resource_record_pre_action 05:57:25 INFO - Running main action method: install 05:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:25 INFO - Reading from file tmpfile_stdout 05:57:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:25 INFO - Reading from file tmpfile_stdout 05:57:25 INFO - Output received: 05:57:25 INFO - Usage: mozinstall [options] installer 05:57:25 INFO - Options: 05:57:25 INFO - -h, --help show this help message and exit 05:57:25 INFO - -d DEST, --destination=DEST 05:57:25 INFO - Directory to install application into. [default: 05:57:25 INFO - "/builds/slave/test"] 05:57:25 INFO - --app=APP Application being installed. [default: firefox] 05:57:25 INFO - mkdir: /builds/slave/test/build/application 05:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:57:42 INFO - Reading from file tmpfile_stdout 05:57:42 INFO - Output received: 05:57:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:42 INFO - Running post-action listener: _resource_record_post_action 05:57:42 INFO - ##### 05:57:42 INFO - ##### Running run-tests step. 05:57:42 INFO - ##### 05:57:42 INFO - Running pre-action listener: _resource_record_pre_action 05:57:42 INFO - Running main action method: run_tests 05:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:42 INFO - Python 2.7.3 05:57:42 INFO - Return code: 0 05:57:42 INFO - grabbing minidump binary from tooltool 05:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:42 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 0x1526640>, '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 0x1527540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15279d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:42 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 05:57:42 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 05:57:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:42 INFO - Return code: 0 05:57:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:43 INFO - Return code: 0 05:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 05:57:43 INFO - Using env: {'DISPLAY': ':0', 05:57:43 INFO - 'HOME': '/home/cltbld', 05:57:43 INFO - 'LANG': 'en_US.UTF-8', 05:57:43 INFO - 'LANGUAGE': 'en_US:en', 05:57:43 INFO - 'LOGNAME': 'cltbld', 05:57:43 INFO - 'MAIL': '/var/mail/cltbld', 05:57:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:43 INFO - 'MOZ_NO_REMOTE': '1', 05:57:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:43 INFO - 'NO_EM_RESTART': '1', 05:57:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:43 INFO - 'PWD': '/builds/slave/test', 05:57:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:43 INFO - 'SHELL': '/bin/bash', 05:57:43 INFO - 'SHLVL': '1', 05:57:43 INFO - 'TERM': 'linux', 05:57:43 INFO - 'TMOUT': '86400', 05:57:43 INFO - 'USER': 'cltbld', 05:57:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009', 05:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:43 INFO - '_': '/tools/buildbot/bin/python'} 05:57:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 05:57:43 INFO - mozversion application_buildid: 20160505030327 05:57:43 INFO - mozversion application_changeset: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b 05:57:43 INFO - mozversion application_display_name: Nightly 05:57:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:43 INFO - mozversion application_name: Firefox 05:57:43 INFO - mozversion application_remotingname: firefox 05:57:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:43 INFO - mozversion application_vendor: Mozilla 05:57:43 INFO - mozversion application_version: 49.0a1 05:57:43 INFO - mozversion platform_buildid: 20160505030327 05:57:43 INFO - mozversion platform_changeset: 369a5ee3a2880a4a98df3a00bf3db8d8f36b181b 05:57:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:43 INFO - mozversion platform_version: 49.0a1 05:57:43 INFO - using testdate: 1462453063 05:57:43 INFO - actual date: 1462453063 05:57:43 INFO - starting webserver on 'localhost:58388' 05:57:43 INFO - SUITE-START | Running 2 tests 05:57:43 INFO - TEST-START | dromaeo_css 05:57:43 INFO - operating with platform_type : linux_ 05:57:43 INFO - Initialising browser for dromaeo_css test... 05:57:43 INFO - TEST-INFO | started process 5386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvhwSV6/profile http://localhost:58388/getInfo.html) 05:57:49 INFO - PROCESS | 5386 | 05:57:49 INFO - PROCESS | 5386 | (process:5456): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:57:49 INFO - PROCESS | 5386 | __metrics Screen width/height:1600/1200 05:57:49 INFO - PROCESS | 5386 | colorDepth:24 05:57:49 INFO - PROCESS | 5386 | Browser inner width/height: 1024/697 05:57:49 INFO - PROCESS | 5386 | __metrics 05:57:50 ERROR - PROCESS | 5386 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:57:53 INFO - TEST-INFO | 5386: exit 0 05:57:53 INFO - Browser initialized. 05:57:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:53 INFO - TEST-INFO | started process 5507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvhwSV6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:54 INFO - PROCESS | 5507 | 05:57:54 INFO - PROCESS | 5507 | (process:5568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:04 INFO - PROCESS | 5507 | RSS: Main: 164556800 05:58:04 INFO - PROCESS | 5507 | 05:58:54 INFO - PROCESS | 5507 | 1462453134504 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] 06:01:02 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58388/tests/dromaeo/cssquery-ext.html) 06:01:03 INFO - PROCESS | 5507 | RSS: Main: 170618880 06:01:03 INFO - PROCESS | 5507 | 06:04:05 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-ext.html (next: http://localhost:58388/tests/dromaeo/cssquery-jquery.html) 06:04:05 INFO - PROCESS | 5507 | RSS: Main: 167841792 06:04:05 INFO - PROCESS | 5507 | 06:07:07 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58388/tests/dromaeo/cssquery-mootools.html) 06:07:07 INFO - PROCESS | 5507 | RSS: Main: 168312832 06:07:07 INFO - PROCESS | 5507 | 06:10:09 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58388/tests/dromaeo/cssquery-prototype.html) 06:10:10 INFO - PROCESS | 5507 | RSS: Main: 166006784 06:10:10 INFO - PROCESS | 5507 | 06:13:12 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58388/tests/dromaeo/cssquery-yui.html) 06:13:13 INFO - PROCESS | 5507 | RSS: Main: 167723008 06:13:13 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | Cycle 1(1): loaded http://localhost:58388/tests/dromaeo/cssquery-yui.html (next: http://localhost:58388/tests/dromaeo/cssquery-dojo.html) 06:16:15 INFO - PROCESS | 5507 | RSS: Main: 169541632 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | __start_tp_report 06:16:15 INFO - PROCESS | 5507 | _x_x_mozilla_page_load 06:16:15 INFO - PROCESS | 5507 | _x_x_mozilla_page_load_details 06:16:15 INFO - PROCESS | 5507 | |i|pagename|runs| 06:16:15 INFO - PROCESS | 5507 | |0;dojo.html;3092.9381412371754;3152.243461569223;3160.3047329587484;3192.1700357906952;3212.229065024395;5169.715665638393;5292.761825717847;5293.417724050351;5331.306930099091;5347.304850369452;5271.472852714736;5287.180487024518;5366.597505187116;5413.918791218125;5420.891582168354;4772.403449568796;4833.830815921444;4861.173600487908;4891.853244402656;4934.432540257881;819.6808291132892;4679.3682852814945;4766.094442056015;4808.687435316693;4816.422029356482;4854.927176092361;4874.049560335736;4877.9268310975185;4895.902081958358;4922.729249891255;4869.293952376921;4901.558859702608;4907.558319751204;4910.1898186799135;4940.530649588283;4713.787879545429;4756;4807.807687692488;4825.034993001379;4873.195922672755;5198.454162312941;5199.220116982445;5202.687838729688;5213.53078222958;5217.113090774577;5560.888782224373;5715.514181294553;5722.284714410699;5722.542196624302;5723.941070901855;5809.128630705386;5844.883102337972;5858.355580886099;5861.472467477947;5892.911606325909;5359.437259087817;5378.865528361783;5381.865453363658;5384.461553844623;5396.514313711746;5712.542996560265;5867.237259156283;5872.060470324813;5888.4700376966275;5891.528677705774;5641.153826925994;5642.181883626851;5648.039833228361;5650.26546548946;5694.117411801178;5711.828645140652;5712.485876271156;5715.057015592464;5719.685417302005;5729.312482502127;5583.190437386556;5681.403452637496;5705.4579814917515;5708.857278568069;5748.856278592985;5668.971655141698;5723.685197314105;5730.111832665943;5731.054376027909;5776.826695199151;4332.025294308755;4344.782760861945;4381.211381951216;4387.4954380246045;4418.5802348776815;3820.6370394812448;3880.301545721797;3952.110775075585;3964.7819369934355;3983.581723918947;5305.602079844027;5503.394626591072;5556.277683901067;5564.888702226014;5590.301212348457;5660.773569057192;5716.971415142981;5744.712764361849;5746.856328591819;5762.9135562966585;5358.223057656696;5418.187271909166;5443.047466693392;5516.393196748354;5550.750216240279;4756.881077973078;4773.9761301193275;4775.06886157196;4788.736619485892;4826.734529600835;5996.490298324604;6024.186734790835;6036.607620504741;6038.456538911519;6043.214382130383;5630.042892708249;5714.514266287412;5757.5393968481585;5828.679422631796;5863.560232982458;5986.311574169026;6005.039193728982;6017.909731354121;6018.458338749533;6019.939800601938;5673.602847800615;5688.345840228427;5691.630044047124;5695.0603150481365;5698.943010569841;5644.887102258014;5764.596478246483;5834.241548598655;5834.737436815439;5888.440598143169;5517.172424136412;5579.442055794388;5609.74756135983;5610.382857885711;5622.32532096151;5519.806806761744;5566.192902029264;5566.805161819317;5571.9442805571425;5603.10350343943;5523.6409633373705;5546.168074788814;5556.055470569932;5595.412481689526;5612.494875461228;5623.2127502148915;5635.633683810539;5656.6888821115235;5682.516986056232;5687.8862422752145;5460;5557.083081291542;5562.3881373048125;5582.995060889079;5605.775768969195 06:16:15 INFO - PROCESS | 5507 | |1;ext.html;649.9772507962219;650.9056186852906;669.6952886436671;670.5440300595593;682.2938258902034;37786.24427511451;38926.41610375846;39066.80466597666;39089.21821563567;39271.41092883609;39726;40331;40434.39348409769;40524.39213411801;40706.185876282456;8432.536210508435;8585.399022068457;8621.13788621139;8648.956755216246;8661.740147795575;8509;8563.700270490534;8571.871421928676;8768.868466973001;8796.340274479408;8746.562671866413;8896.644134234622;8899.510526921016;8909.287257019423;8934;8800.075992020842;8817.647294108228;8863.556822158866;8866.556672166365;8883.600237989274;8562.61468233931;8639.65441382344;8666.176713212235;8686.782830429227;8691.521966291852;40358.192836143404;40755.38866916999;40800;40898.1820363591;40919.59080409217;3643.8178091095338;3699.9815000924823;3766.077311058808;3768.7550309229814;3820.6752426043818;31690.207744806336;31861;32059.35881282361;32171.51742723861;33448.66551334504;4261.21167583998;4271.97864010681;4304;4323.762193079411;4381.868543943687;261594;262106;262933;265107;265351;33831.830840845636;34209.31581368409;57007;57158.7142064287;57597;34692.826535867156;34869.825650871586;34902.476462853076;34970.65029349674;35114;14991.100533967996;15161.469348572748;15167.696646067017;15177.165255911032;15248.085114893142;13122;13164;13242.470301188037;13246.602601921764;13257.801132983013;8434.662613495391;8753.64985400577;8803.723460098377;8840.734777956543;8888.955555222183;3334.3998080345773;3420.110771199506;3422.9486557701653;3470.479428085757;3493.807840568793;1080.5569716416232;1088.5373716170595;1189.3042570096418;1213.4296880466343;1220.9816852747215;32079.099694432807;32332.515012274835;32450.188745281557;32751;33000.504992425136;1155.4107405223397;1277.0549793153;1308.5584911682215;1326.8938484921184;1333.6932505523785;16891.23989420479;16965.15174241283;17249.310027598756;17626.5593360167;17922.462326130237;473071;484797;486199;486815;487877;58679;59120;59199.70400147972;59601.70199148977;59829.40170598238;1404.2206575350574;1459.9854001459848;1472.7054589082013;1476.3946781819402;1574.8976316539388;33177.668223318426;33283.500747488324;33362.499562507066;33657.49513757246;33743.4938475928;50494.2425863605;51014.74492627513;51281.23078153905;51596.48403515917;51640.22539661833;434834;435236;439212;439441;441361;28112.71887281101;29226.56160157557;29231.415371692874;29239.122826315244;29427.55858662079;47681;47751;48138.75930620325;48626.27060594023;49277.507224928726;37058.6294137066;40300;41945.58054419417;42053.36919946264;42353.364699530146;37670.62329376671;37881.62118378781;37983.620163798005;39397;40686;33243.16892077717;37765.62234377621;37872;38551.807240963615;41425;32289.35421291608;32465.925645067913;35492.11269718174;35879.282414351044;36128.819355903055;27809.860950695118;28445;28597;28687.282817929718;28764.712352876202 06:16:15 INFO - PROCESS | 5507 | |2;jquery.html;390.894458496206;393.29403720322017;400.43138742984956;401.44600451377096;401.5241938303113;14034.157950522977;16014.83985160148;17759.112044397792;18427;18532.814671853277;14625.195614241213;17205.7419138713;17220.13899305036;17352.13239338031;18601.7209741854;5518.91721624176;5538.307711536058;5652.971735141318;5678.545716342683;5684.488396044355;5542.584306177053;5568.52667523259;5630.465105814941;5699.601027928046;5699.8575035624235;5412.485813847678;5635.690037047961;5654.321481422235;5654.9151762723595;5665.263515742948;5574.470425309589;5635.295588051494;5655.519280861132;5657.801976930808;5661.264035675356;4869.366982292315;4975.378077740283;5026.547610715053;5042.369703787027;5083.822066227664;21641.783582164135;22125.889370553043;22499.77500224993;22549.774502255095;22568.66147007796;2554.5912653975274;2564.7691707746394;2609;2834.319763256824;2852.001799370204;14029.088109272865;14224.502142424966;14323.78514322286;14460.421583136662;14504;1922.6250881078195;1969.6454638165123;2009.1963214714085;2019.4446527204989;2035.552178520738;61359;70916.29083709148;72480;75185.62407187984;76423.61788191079;10066.848997265048;10436.63471778484;10581.523831427605;10702.518386672618;10819.567217311376;14685;14697.118172909446;14771.33528991198;14787.556373308818;14808.259587020606;8137.918620813834;8260.339172866277;8280.089190189074;8312.21034001769;8420.031696354876;8138.837223255502;8227.753167404988;8369.707060252862;8383.455075420079;8396.958015210008;6326.746930122744;6587.374199451045;6594.142761441078;6611.23970743361;6690.5316627836555;1910.6751852185162;1954.1499447740277;1979.8020197980086;1987.4335814292858;2008.8493362997542;998.8052329795765;1083.6748975307376;1085.46812062089;1086.5979587552656;1116.7654792493504;16982.57543561421;18253.17860696272;18381.908090459463;18658.906705466656;18843.29660467656;1088.9727756806144;1104.2215238257008;1132.6092498088146;1133.7335726104359;1140.680609429361;10868.293560918515;11065.668029959113;11098.334099954029;11178.105751539857;11182.273152245078;484734;499550;500343;501921;550290;79984;84441;84620;85377;87232.56383718041;1083.2525557365393;1085.0722632149398;1090.825467925144;1111.6387174168428;1128.3681138562267;16477.176141193133;16757.32970681159;16905.408310709066;16953.74569381485;17174.31302747926;35377.646223537435;37376.252474950896;37447.43828842624;37501.6249837509;37956.43065353967;48195;48458.75770621125;48645;48890.51109488859;49175.75412122916;8239.794005149919;8526.488410695378;8542.701005464778;8747.956260218658;8861.158189971942;11365.772684546428;12602.180858244184;13830.308484575933;13889.444422222998;13902.096363736326;11826.645200643994;11833.881661183623;11885.405729713653;11980.700482488008;12144.939275303921;11646;11802.291862488279;11825.645230643095;12194.451249693962;12199.390030498262;12207.633770986884;12239.69400764988;12252.08109391817;12261.570845020382;12387.380630968595;8695.739127826175;8778.648854045767;8780.604872780612;8816.074312197126;8910.777230569287;10899.615113893327;11758.823617645914;11818.172727909308;12184.817227741769;12195.390230488263 06:16:15 INFO - PROCESS | 5507 | |3;mootools.html;1524.9466268680594;1549.1324858079472;1674.3051633572068;1724.3188940368564;1744.9738253926184;7253.347198752112;7440.144383395911;7722.96138519308;7734.419918506113;7786;7775.844483110334;7799.493032952868;7819.139894611588;7827.060752709668;7830.8042298942555;2189.4854709143337;2228.5988522066023;2233.3076746208726;2250.673652320421;2260.977390226093;2094.8847813370257;2121;2123.140128248062;2141.2612648636195;2196.9560608787815;2192.188890110653;2213.0373287619855;2220.100859152046;2231.7545070042283;2235.3964429604;2175.216921908112;2182.0508078985613;2184.2355175688463;2187.201671389947;2188.67169924511;2195.7255343082115;2218.1460137846884;2227.042371780134;2246.3148739634403;2259.5029093599383;7957.9204207957755;7978.601069946538;7991.120976692559;8056.637451314705;8062.395320350938;4864.586510146642;4967.205247160473;5034.823781167678;5042.117629414838;5042.571381432583;3180.634227063871;3250.691184337484;3356.7146792522667;3360.6471320511237;3396.9150771230916;1103.906167975715;1123.5337335005963;1125.2404626876908;1128.4470609401417;1146.5299227316843;10919.290246134055;10966.780664386668;10975.121990240841;10977.560897564168;10985.395803230898;4324.870253892388;4397.670174736843;4449.9555004450185;4477.2164871147415;4549.522300158502;9364.110409511086;9430.915444723807;9436.90563094374;9439.433633981984;9479.24166066713;4964.1809101498575;4969.975150124226;4971.105201063771;4972.801087956514;4992.026554821848;4149.107941792468;4490.932636010462;4506.887327816765;4633.745144017112;4643.6517261205545;3722.9813850930573;3808.8857334280015;3825.3496905526126;3845.8461661533224;3861.768293902375;1210.7820592293297;1219.3842109734528;1243.3286025546286;1247.2828123828835;1247.9563215287421;905.3300557587338;1010.6361709784471;1035.7980193862124;1048.8112139814755;1066.4134725900724;5567.777288908479;5713.05734553794;5806.666434744627;5806.796762113306;5881.5588830837005;481.14836738971826;482.9082474329866;483.995160048395;1037.9325343852624;1088.1349327284827;3908.394198899175;3949.624785645359;3984.8406063757125;3999.8400063997697;4039.4546736190237;9658.468784216795;9993.600255989679;10028.498575071217;10077.748056298651;10078.949605252074;9868.555914983843;9929;9968.950155249177;9979.80040399188;9987.900120998696;7420.628968551551;7528.849423011509;7621.780515117554;7742.845143097106;7768.572728499987;5685.488306052475;5703.771849126155;5818.359980402068;5832.825015249549;5881.264841894763;8952.373333866566;9092.545372731469;9138.497382644018;9158.725238242863;9176.632934682804;9084.636614535344;9209.815803683754;9234.9538252311;9499.572519236513;9500.809983800424;6460.547761656639;6703.865922681616;6841.828954276183;6909.205441374306;7010.404115650227;8093.352531797324;8121.796955075934;8122.268995790408;8145.144759800372;8162.510249385056;7055.541389809646;7089.361957423856;7231.16841563227;7240.312170343809;7400.888986665097;6967.930320696728;7035.929640703527;7039.401650859734;7079.539829911039;7110.431165506644;6573.737050518117;6693.397594216543;6705.2959439258175;6721.93278067213;6725.4619630430425;4832.830850920201;4868.634852386156;4875.658703890694;4878.975605121952;4912.582430493448;5094.592432605456;5094.719790411415;5096.949030509796;5097.464766199644;5171.043356978971 06:16:15 INFO - PROCESS | 5507 | |4;prototype.html;318.982455964922;319.257725787544;320.1500017453661;325.20811823210477;335.9848806803694;5356.330458692663;5484.7531861066245;5525.640833345829;5525.850265348753;5527.364353099395;5413.350397952241;5439.755211015504;5441.483059109388;5445.346558412996;5470.9452905471035;4014.919701605966;4078.0416602098485;4221.387898754679;4223.598758117989;4230.513490948534;4218.894527636819;4232.217039847638;4245.915081698379;4253.425787518692;4256.957045523851;4156.482883747425;4174.77038762868;4204.1801848639525;4213.136307057046;4215.093754842708;4062.289099407592;4136.958630413687;4162.146759914225;4177.4569305990335;4214.599613036757;3659.981700091509;3666.4683620874825;3668.192997540537;3679.5768486624115;3688.5389326334207;5232.973835130838;5255.132903071027;5275.129603615399;5289.153735402356;5307.363116426015;4779.61763058958;4845.394325709286;4854.538818812207;4862.7325497097645;4908.288298196777;5664.660120392789;5666.773329066832;5686.232358631614;5719.370869204384;5798.449147330997;4127.731697439657;4130.63688982638;4135.152293779798;4148.8133034013545;4162.666986641061;5807.390224026459;5944.335586035917;5976.62320788753;5984.760609575612;6011.458968692838;4183.937240941388;4195.265828480004;4203.222403855297;4236.2252724465525;4256.765877876746;4286.428143114106;4302.65578753699;4314.180305741962;4315.611594956469;4323.0705398339505;4555.931661025087;4836.806527738921;4885.902281954341;4897.1674815281485;4912;5742.511886489611;5781.19063331134;5781.479666830005;5786.450287222707;5802.593818432669;1508.1403599948144;1512.6520900193018;1515.674130062042;1519.2100107943807;1521.680447106098;953.4660590069583;990.0198803184795;992.2905122837207;1028.1517747858047;1036.0261354326908;5891.116332550066;5957.106434034929;5958.344582095966;5992.520598352121;5992.880142397127;6181.84545386369;6281.528885333527;6311.621302721851;6328.6202827830475;6333.334999825044;5328.440513746001;5635.323761148688;5648;5673.744681489343;5962.880742385128;3409.4203985322556;3417.7778444401033;3421.3499435107747;3437.553118094682;3439.9656003439645;6478.838029049311;6631;6646.26891041985;6670.899936500957;6693;6529.738810447624;6536.738530458823;6553.672316384162;6565.507586930999;6592.406683398422;6551.770688025897;6617.9669101655145;6626.138601981808;6652.8669426611195;6676.798176328308;6407.935920640734;6411.166548348685;6420.6789660517725;6437.388448097423;6462.3537646235;6188.81433556994;6275.52933529978;6282.842928926813;6283.837490064353;6321.209848768904;6457.67711614408;6684.398404143651;6685.364890335411;6716.496262780213;6746.561473504403;4285.91428171441;4358.891027724332;4380.255356589324;4384.978075109604;4387.451568553931;6212.502999760099;6370.585911915896;6418.138739765416;6430.485561155003;6459.128017717736;6231.75072997075;6242.219722534684;6245.594036387621;6247.281562620356;6247.375262473898;6091.147239386578;6188.597741146811;6200.596961197508;6233.812985610439;6272.529560282906;5434.483724046209;5444.564434845282;5721.771129154788;6139.662318572521;6158.706671599014;5794.739236734273;5804.303483581997;5806.5645076618575;5824.504917082096;5846.707664616667;5584.636998595079;5681.9147712783515;5683.829485115453;5690.3456102548735;5701.522071536277 06:16:15 INFO - PROCESS | 5507 | |5;yui.html;795.8925545051418;820.9384296177789;869.7738587967131;879.9340049496285;885.4465958775766;14866.47967321144;15254.23728813559;15465.226738663065;15988.84011159888;16638.50084497464;15169.393224271043;15194.924025379885;15244.618884527892;15303.69392612147;15332.61668458289;704.2921863527148;817.2236375443323;827.1191181391829;829.1832544943256;844.8690452979768;845.2181731898;847.6524624903791;852.2415050604935;854.2055888024136;854.3976496569934;887.5828360670507;889.6263569300909;890.9242714369286;893.2139717049021;895.0467751844297;881.4094556647062;883.659790980474;884.0982198157875;884.9115088491163;887.3389324952919;629.1003864473801;641.8138739765462;643.0771842406162;644.9097126402307;650.4893658478072;14978.325975331136;15044.473443429428;15063.397464101423;15089.924550377287;15091;13875.236861972588;14130.081544699664;14287.214203218819;14298.28508574567;14384.64038399038;11941.641750747405;11975.94012029943;12048.156629035971;12104.092193085466;12189.451474683661;3880.6715970417804;3894.357431023878;3912.2371137628174;3939.5469521005166;3965.6034396560403;53718.194227086235;62645.74708505804;62708.37291627071;62784;63075;11352;11374.54501819918;11417.029552488131;11467.369294688706;11484.483198256099;19120.61758764845;19155.425337239903;19269.61460770777;19280;19323.4202973911;8548.401611887108;8655.523946182895;8655.56722163902;8682.479051256945;8760;4672.322513235562;4699.976500117477;4727.881802954954;4744.4350800654265;4855.660103792771;3353.2622822978906;3449.448088305909;3450.9827450862585;3473.0622731862254;3475.2354482013916;649.1074772188241;652.1619718661498;653.2977049671528;659.8317429055656;660.4947215380238;706.8515611721596;724.3119036914952;773.6866569039548;777.6150805351388;790.517784151667;9050.922686286694;9636.46999415039;9720.368176068532;9739.756506087404;9893.554790034466;641.8074577626787;722.2957616324042;722.9674664640104;736.7568702328219;772.9304362607393;4547.795349209294;4627.167109920179;4630.768461576975;4647.535246475393;4656.953430465652;57178.7141064292;57887.421125788205;59342.40657593369;59448.70275648594;60909.390906091256;55747.72126139343;57215.71392143013;57330.713346433;58064.70967645219;58333;47984.5201547987;50300.748496257285;53981.46018539764;55701;56194.71902640461;9651.9034809651;9755.951220243853;9767.267454940766;9800.781755070038;9828.655997040069;33954.83022584871;34358.65641343655;34934.82532587321;35539.28921421505;35560.64439355573;42822.571774283104;44833.55166448294;45792.08415831732;45855.77072114618;46248.30627540657;12379.257244565355;12600.621981340575;12672.936635316764;12700;12939.741205175655;13947.16317020982;14296.857031429552;14550.85449145495;14616.70766584641;14978.775318370015;12757.127750842797;12892.226466412045;12904.677383065498;13316.46734130624;13505.797413038616;13002.934985325013;13535.72928541404;13561.79657305161;13614.38735256896;13831.792523112363;11572;13260.270685112026;13315.733685326046;13354.332283385986;14130.293485325898;11070.889291106985;11071.50178241965;11327.490262938023;11344.149188811038;11517.424128793695;11377.601783937522;11379.658610241706;11467.713307167387;11612.361320127475;11658.88341116612 06:16:15 INFO - PROCESS | 5507 | __end_tp_report 06:16:15 INFO - PROCESS | 5507 | __start_cc_report 06:16:15 INFO - PROCESS | 5507 | _x_x_mozilla_cycle_collect,356 06:16:15 INFO - PROCESS | 5507 | __end_cc_report 06:16:15 INFO - PROCESS | 5507 | __startTimestamp1462454175764__endTimestamp 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | ------- Summary: start ------- 06:16:15 INFO - PROCESS | 5507 | Number of tests: 6 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#0] dojo.html Cycles:165 Average:5301.78 Median:5566.19 stddev:707.18 (12.7%) stddev-sans-first:687.79 06:16:15 INFO - PROCESS | 5507 | Values: 3092.9 3152.2 3160.3 3192.2 3212.2 5169.7 5292.8 5293.4 5331.3 5347.3 5271.5 5287.2 5366.6 5413.9 5420.9 4772.4 4833.8 4861.2 4891.9 4934.4 819.7 4679.4 4766.1 4808.7 4816.4 4854.9 4874.0 4877.9 4895.9 4922.7 4869.3 4901.6 4907.6 4910.2 4940.5 4713.8 4756.0 4807.8 4825.0 4873.2 5198.5 5199.2 5202.7 5213.5 5217.1 5560.9 5715.5 5722.3 5722.5 5723.9 5809.1 5844.9 5858.4 5861.5 5892.9 5359.4 5378.9 5381.9 5384.5 5396.5 5712.5 5867.2 5872.1 5888.5 5891.5 5641.2 5642.2 5648.0 5650.3 5694.1 5711.8 5712.5 5715.1 5719.7 5729.3 5583.2 5681.4 5705.5 5708.9 5748.9 5669.0 5723.7 5730.1 5731.1 5776.8 4332.0 4344.8 4381.2 4387.5 4418.6 3820.6 3880.3 3952.1 3964.8 3983.6 5305.6 5503.4 5556.3 5564.9 5590.3 5660.8 5717.0 5744.7 5746.9 5762.9 5358.2 5418.2 5443.0 5516.4 5550.8 4756.9 4774.0 4775.1 4788.7 4826.7 5996.5 6024.2 6036.6 6038.5 6043.2 5630.0 5714.5 5757.5 5828.7 5863.6 5986.3 6005.0 6017.9 6018.5 6019.9 5673.6 5688.3 5691.6 5695.1 5698.9 5644.9 5764.6 5834.2 5834.7 5888.4 5517.2 5579.4 5609.7 5610.4 5622.3 5519.8 5566.2 5566.8 5571.9 5603.1 5523.6 5546.2 5556.1 5595.4 5612.5 5623.2 5635.6 5656.7 5682.5 5687.9 5460.0 5557.1 5562.4 5583.0 5605.8 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#1] ext.html Cycles:180 Average:54674.08 Median:38739.11 stddev:107857.94 (278.4%) stddev-sans-first:108084.24 06:16:15 INFO - PROCESS | 5507 | Values: 650.0 650.9 669.7 670.5 682.3 37786.2 38926.4 39066.8 39089.2 39271.4 39726.0 40331.0 40434.4 40524.4 40706.2 8432.5 8585.4 8621.1 8649.0 8661.7 8509.0 8563.7 8571.9 8768.9 8796.3 8746.6 8896.6 8899.5 8909.3 8934.0 8800.1 8817.6 8863.6 8866.6 8883.6 8562.6 8639.7 8666.2 8686.8 8691.5 40358.2 40755.4 40800.0 40898.2 40919.6 3643.8 3700.0 3766.1 3768.8 3820.7 31690.2 31861.0 32059.4 32171.5 33448.7 4261.2 4272.0 4304.0 4323.8 4381.9 261594.0 262106.0 262933.0 265107.0 265351.0 33831.8 34209.3 57007.0 57158.7 57597.0 34692.8 34869.8 34902.5 34970.7 35114.0 14991.1 15161.5 15167.7 15177.2 15248.1 13122.0 13164.0 13242.5 13246.6 13257.8 8434.7 8753.6 8803.7 8840.7 8889.0 3334.4 3420.1 3422.9 3470.5 3493.8 1080.6 1088.5 1189.3 1213.4 1221.0 32079.1 32332.5 32450.2 32751.0 33000.5 1155.4 1277.1 1308.6 1326.9 1333.7 16891.2 16965.2 17249.3 17626.6 17922.5 473071.0 484797.0 486199.0 486815.0 487877.0 58679.0 59120.0 59199.7 59601.7 59829.4 1404.2 1460.0 1472.7 1476.4 1574.9 33177.7 33283.5 33362.5 33657.5 33743.5 50494.2 51014.7 51281.2 51596.5 51640.2 434834.0 435236.0 439212.0 439441.0 441361.0 28112.7 29226.6 29231.4 29239.1 29427.6 47681.0 47751.0 48138.8 48626.3 49277.5 37058.6 40300.0 41945.6 42053.4 42353.4 37670.6 37881.6 37983.6 39397.0 40686.0 33243.2 37765.6 37872.0 38551.8 41425.0 32289.4 32465.9 35492.1 35879.3 36128.8 27809.9 28445.0 28597.0 28687.3 28764.7 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#2] jquery.html Cycles:180 Average:28614.33 Median:22312.83 stddev:83233.93 (373.0%) stddev-sans-first:83440.44 06:16:15 INFO - PROCESS | 5507 | Values: 390.9 393.3 400.4 401.4 401.5 14034.2 16014.8 17759.1 18427.0 18532.8 14625.2 17205.7 17220.1 17352.1 18601.7 5518.9 5538.3 5653.0 5678.5 5684.5 5542.6 5568.5 5630.5 5699.6 5699.9 5412.5 5635.7 5654.3 5654.9 5665.3 5574.5 5635.3 5655.5 5657.8 5661.3 4869.4 4975.4 5026.5 5042.4 5083.8 21641.8 22125.9 22499.8 22549.8 22568.7 2554.6 2564.8 2609.0 2834.3 2852.0 14029.1 14224.5 14323.8 14460.4 14504.0 1922.6 1969.6 2009.2 2019.4 2035.6 61359.0 70916.3 72480.0 75185.6 76423.6 10066.8 10436.6 10581.5 10702.5 10819.6 14685.0 14697.1 14771.3 14787.6 14808.3 8137.9 8260.3 8280.1 8312.2 8420.0 8138.8 8227.8 8369.7 8383.5 8397.0 6326.7 6587.4 6594.1 6611.2 6690.5 1910.7 1954.1 1979.8 1987.4 2008.8 998.8 1083.7 1085.5 1086.6 1116.8 16982.6 18253.2 18381.9 18658.9 18843.3 1089.0 1104.2 1132.6 1133.7 1140.7 10868.3 11065.7 11098.3 11178.1 11182.3 484734.0 499550.0 500343.0 501921.0 550290.0 79984.0 84441.0 84620.0 85377.0 87232.6 1083.3 1085.1 1090.8 1111.6 1128.4 16477.2 16757.3 16905.4 16953.7 17174.3 35377.6 37376.3 37447.4 37501.6 37956.4 48195.0 48458.8 48645.0 48890.5 49175.8 8239.8 8526.5 8542.7 8748.0 8861.2 11365.8 12602.2 13830.3 13889.4 13902.1 11826.6 11833.9 11885.4 11980.7 12144.9 11646.0 11802.3 11825.6 12194.5 12199.4 12207.6 12239.7 12252.1 12261.6 12387.4 8695.7 8778.6 8780.6 8816.1 8910.8 10899.6 11758.8 11818.2 12184.8 12195.4 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#3] mootools.html Cycles:180 Average:5384.25 Median:4970.54 stddev:2948.15 (59.3%) stddev-sans-first:2942.16 06:16:15 INFO - PROCESS | 5507 | Values: 1524.9 1549.1 1674.3 1724.3 1745.0 7253.3 7440.1 7723.0 7734.4 7786.0 7775.8 7799.5 7819.1 7827.1 7830.8 2189.5 2228.6 2233.3 2250.7 2261.0 2094.9 2121.0 2123.1 2141.3 2197.0 2192.2 2213.0 2220.1 2231.8 2235.4 2175.2 2182.1 2184.2 2187.2 2188.7 2195.7 2218.1 2227.0 2246.3 2259.5 7957.9 7978.6 7991.1 8056.6 8062.4 4864.6 4967.2 5034.8 5042.1 5042.6 3180.6 3250.7 3356.7 3360.6 3396.9 1103.9 1123.5 1125.2 1128.4 1146.5 10919.3 10966.8 10975.1 10977.6 10985.4 4324.9 4397.7 4450.0 4477.2 4549.5 9364.1 9430.9 9436.9 9439.4 9479.2 4964.2 4970.0 4971.1 4972.8 4992.0 4149.1 4490.9 4506.9 4633.7 4643.7 3723.0 3808.9 3825.3 3845.8 3861.8 1210.8 1219.4 1243.3 1247.3 1248.0 905.3 1010.6 1035.8 1048.8 1066.4 5567.8 5713.1 5806.7 5806.8 5881.6 481.1 482.9 484.0 1037.9 1088.1 3908.4 3949.6 3984.8 3999.8 4039.5 9658.5 9993.6 10028.5 10077.7 10078.9 9868.6 9929.0 9969.0 9979.8 9987.9 7420.6 7528.8 7621.8 7742.8 7768.6 5685.5 5703.8 5818.4 5832.8 5881.3 8952.4 9092.5 9138.5 9158.7 9176.6 9084.6 9209.8 9235.0 9499.6 9500.8 6460.5 6703.9 6841.8 6909.2 7010.4 8093.4 8121.8 8122.3 8145.1 8162.5 7055.5 7089.4 7231.2 7240.3 7400.9 6967.9 7035.9 7039.4 7079.5 7110.4 6573.7 6693.4 6705.3 6721.9 6725.5 4832.8 4868.6 4875.7 4879.0 4912.6 5094.6 5094.7 5096.9 5097.5 5171.0 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#4] prototype.html Cycles:180 Average:5003.75 Median:5609.98 stddev:1546.67 (27.6%) stddev-sans-first:1510.51 06:16:15 INFO - PROCESS | 5507 | Values: 319.0 319.3 320.2 325.2 336.0 5356.3 5484.8 5525.6 5525.9 5527.4 5413.4 5439.8 5441.5 5445.3 5470.9 4014.9 4078.0 4221.4 4223.6 4230.5 4218.9 4232.2 4245.9 4253.4 4257.0 4156.5 4174.8 4204.2 4213.1 4215.1 4062.3 4137.0 4162.1 4177.5 4214.6 3660.0 3666.5 3668.2 3679.6 3688.5 5233.0 5255.1 5275.1 5289.2 5307.4 4779.6 4845.4 4854.5 4862.7 4908.3 5664.7 5666.8 5686.2 5719.4 5798.4 4127.7 4130.6 4135.2 4148.8 4162.7 5807.4 5944.3 5976.6 5984.8 6011.5 4183.9 4195.3 4203.2 4236.2 4256.8 4286.4 4302.7 4314.2 4315.6 4323.1 4555.9 4836.8 4885.9 4897.2 4912.0 5742.5 5781.2 5781.5 5786.5 5802.6 1508.1 1512.7 1515.7 1519.2 1521.7 953.5 990.0 992.3 1028.2 1036.0 5891.1 5957.1 5958.3 5992.5 5992.9 6181.8 6281.5 6311.6 6328.6 6333.3 5328.4 5635.3 5648.0 5673.7 5962.9 3409.4 3417.8 3421.3 3437.6 3440.0 6478.8 6631.0 6646.3 6670.9 6693.0 6529.7 6536.7 6553.7 6565.5 6592.4 6551.8 6618.0 6626.1 6652.9 6676.8 6407.9 6411.2 6420.7 6437.4 6462.4 6188.8 6275.5 6282.8 6283.8 6321.2 6457.7 6684.4 6685.4 6716.5 6746.6 4285.9 4358.9 4380.3 4385.0 4387.5 6212.5 6370.6 6418.1 6430.5 6459.1 6231.8 6242.2 6245.6 6247.3 6247.4 6091.1 6188.6 6200.6 6233.8 6272.5 5434.5 5444.6 5721.8 6139.7 6158.7 5794.7 5804.3 5806.6 5824.5 5846.7 5584.6 5681.9 5683.8 5690.3 5701.5 06:16:15 INFO - PROCESS | 5507 | 06:16:15 INFO - PROCESS | 5507 | [#5] yui.html Cycles:180 Average:15398.54 Median:25437.74 stddev:17578.77 (69.1%) stddev-sans-first:17593.88 06:16:15 INFO - PROCESS | 5507 | Values: 795.9 820.9 869.8 879.9 885.4 14866.5 15254.2 15465.2 15988.8 16638.5 15169.4 15194.9 15244.6 15303.7 15332.6 704.3 817.2 827.1 829.2 844.9 845.2 847.7 852.2 854.2 854.4 887.6 889.6 890.9 893.2 895.0 881.4 883.7 884.1 884.9 887.3 629.1 641.8 643.1 644.9 650.5 14978.3 15044.5 15063.4 15089.9 15091.0 13875.2 14130.1 14287.2 14298.3 14384.6 11941.6 11975.9 12048.2 12104.1 12189.5 3880.7 3894.4 3912.2 3939.5 3965.6 53718.2 62645.7 62708.4 62784.0 63075.0 11352.0 11374.5 11417.0 11467.4 11484.5 19120.6 19155.4 19269.6 19280.0 19323.4 8548.4 8655.5 8655.6 8682.5 8760.0 4672.3 4700.0 4727.9 4744.4 4855.7 3353.3 3449.4 3451.0 3473.1 3475.2 649.1 652.2 653.3 659.8 660.5 706.9 724.3 773.7 777.6 790.5 9050.9 9636.5 9720.4 9739.8 9893.6 641.8 722.3 723.0 736.8 772.9 4547.8 4627.2 4630.8 4647.5 4657.0 57178.7 57887.4 59342.4 59448.7 60909.4 55747.7 57215.7 57330.7 58064.7 58333.0 47984.5 50300.7 53981.5 55701.0 56194.7 9651.9 9756.0 9767.3 9800.8 9828.7 33954.8 34358.7 34934.8 35539.3 35560.6 42822.6 44833.6 45792.1 45855.8 46248.3 12379.3 12600.6 12672.9 12700.0 12939.7 13947.2 14296.9 14550.9 14616.7 14978.8 12757.1 12892.2 12904.7 13316.5 13505.8 13002.9 13535.7 13561.8 13614.4 13831.8 11572.0 13260.3 13315.7 13354.3 14130.3 11070.9 11071.5 11327.5 11344.1 11517.4 11377.6 11379.7 11467.7 11612.4 11658.9 06:16:15 INFO - PROCESS | 5507 | -------- Summary: end -------- 06:16:15 INFO - PROCESS | 5507 | 06:16:16 INFO - TEST-INFO | 5507: exit 0 06:16:16 INFO - TEST-OK | dromaeo_css | took 1112973ms 06:16:16 INFO - TEST-START | kraken 06:16:16 INFO - operating with platform_type : linux_ 06:16:16 INFO - Initialising browser for kraken test... 06:16:16 INFO - TEST-INFO | started process 5744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrvRTl/profile http://localhost:58388/getInfo.html) 06:16:20 INFO - PROCESS | 5744 | 06:16:20 INFO - PROCESS | 5744 | (process:5810): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:21 INFO - PROCESS | 5744 | __metrics Screen width/height:1600/1200 06:16:21 INFO - PROCESS | 5744 | colorDepth:24 06:16:21 INFO - PROCESS | 5744 | Browser inner width/height: 1024/697 06:16:21 INFO - PROCESS | 5744 | __metrics 06:16:21 ERROR - PROCESS | 5744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:16:22 INFO - TEST-INFO | 5744: exit 0 06:16:22 INFO - Browser initialized. 06:16:22 INFO - Running cycle 1/1 for kraken test... 06:16:22 INFO - TEST-INFO | started process 5861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrvRTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:24 INFO - PROCESS | 5861 | 06:16:24 INFO - PROCESS | 5861 | (process:5922): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:16:34 INFO - PROCESS | 5861 | RSS: Main: 165122048 06:16:34 INFO - PROCESS | 5861 | 06:16:36 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58388/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:37 INFO - PROCESS | 5861 | RSS: Main: 169779200 06:16:37 INFO - PROCESS | 5861 | 06:16:40 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58388/tests/kraken/driver.html?testName=audio-dft) 06:16:41 INFO - PROCESS | 5861 | RSS: Main: 172236800 06:16:41 INFO - PROCESS | 5861 | 06:16:44 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58388/tests/kraken/driver.html?testName=audio-fft) 06:16:44 INFO - PROCESS | 5861 | RSS: Main: 164102144 06:16:44 INFO - PROCESS | 5861 | 06:16:46 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58388/tests/kraken/driver.html?testName=audio-oscillator) 06:16:47 INFO - PROCESS | 5861 | RSS: Main: 164306944 06:16:47 INFO - PROCESS | 5861 | 06:16:49 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:50 INFO - PROCESS | 5861 | RSS: Main: 165806080 06:16:50 INFO - PROCESS | 5861 | 06:16:53 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58388/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:53 INFO - PROCESS | 5861 | RSS: Main: 166154240 06:16:53 INFO - PROCESS | 5861 | 06:16:57 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58388/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:57 INFO - PROCESS | 5861 | RSS: Main: 166371328 06:16:57 INFO - PROCESS | 5861 | 06:17:00 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58388/tests/kraken/driver.html?testName=json-parse-financial) 06:17:01 INFO - PROCESS | 5861 | RSS: Main: 168562688 06:17:01 INFO - PROCESS | 5861 | 06:17:02 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:03 INFO - PROCESS | 5861 | RSS: Main: 168054784 06:17:03 INFO - PROCESS | 5861 | 06:17:05 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:05 INFO - PROCESS | 5861 | RSS: Main: 168337408 06:17:05 INFO - PROCESS | 5861 | 06:17:07 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:08 INFO - PROCESS | 5861 | RSS: Main: 168321024 06:17:08 INFO - PROCESS | 5861 | 06:17:11 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:11 INFO - PROCESS | 5861 | RSS: Main: 168923136 06:17:11 INFO - PROCESS | 5861 | 06:17:14 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:15 INFO - PROCESS | 5861 | RSS: Main: 169082880 06:17:15 INFO - PROCESS | 5861 | 06:17:16 INFO - PROCESS | 5861 | Cycle 1(1): loaded http://localhost:58388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58388/tests/kraken/driver.html?testName=ai-astar) 06:17:17 INFO - PROCESS | 5861 | RSS: Main: 170106880 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | __start_tp_report 06:17:17 INFO - PROCESS | 5861 | _x_x_mozilla_page_load 06:17:17 INFO - PROCESS | 5861 | _x_x_mozilla_page_load_details 06:17:17 INFO - PROCESS | 5861 | |i|pagename|runs| 06:17:17 INFO - PROCESS | 5861 | |0;ai-astar;116;114;113;113;112;124;112;113;111;112 06:17:17 INFO - PROCESS | 5861 | |1;audio-beat-detection;154;134;158;179;132;153;154;128;193;129 06:17:17 INFO - PROCESS | 5861 | |2;audio-dft;162;162;162;160;160;164;177;162;165;162 06:17:17 INFO - PROCESS | 5861 | |3;audio-fft;73;76;72;157;79;73;73;74;174;77 06:17:17 INFO - PROCESS | 5861 | |4;audio-oscillator;92;93;147;92;91;94;153;92;92;150 06:17:17 INFO - PROCESS | 5861 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;118;118 06:17:17 INFO - PROCESS | 5861 | |6;imaging-darkroom;148;147;147;145;146;147;146;145;147;146 06:17:17 INFO - PROCESS | 5861 | |7;imaging-desaturate;95;95;97;96;95;95;95;96;95;96 06:17:17 INFO - PROCESS | 5861 | |8;json-parse-financial;59;60;59;59;61;58;57;74;56;60 06:17:17 INFO - PROCESS | 5861 | |9;json-stringify-tinderbox;59;59;59;59;59;59;58;58;58;58 06:17:17 INFO - PROCESS | 5861 | |10;stanford-crypto-aes;78;76;78;77;77;77;77;78;81;77 06:17:17 INFO - PROCESS | 5861 | |11;stanford-crypto-ccm;130;124;134;124;124;123;121;123;195;133 06:17:17 INFO - PROCESS | 5861 | |12;stanford-crypto-pbkdf2;168;168;171;172;177;172;168;171;169;166 06:17:17 INFO - PROCESS | 5861 | |13;stanford-crypto-sha256-iterative;76;72;73;71;69;67;68;69;74;69 06:17:17 INFO - PROCESS | 5861 | __end_tp_report 06:17:17 INFO - PROCESS | 5861 | __start_cc_report 06:17:17 INFO - PROCESS | 5861 | _x_x_mozilla_cycle_collect,852 06:17:17 INFO - PROCESS | 5861 | __end_cc_report 06:17:17 INFO - PROCESS | 5861 | __startTimestamp1462454237096__endTimestamp 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | ------- Summary: start ------- 06:17:17 INFO - PROCESS | 5861 | Number of tests: 14 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:3.77 (3.3%) stddev-sans-first:3.93 06:17:17 INFO - PROCESS | 5861 | Values: 116.0 114.0 113.0 113.0 112.0 124.0 112.0 113.0 111.0 112.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:154.00 stddev:21.81 (14.2%) stddev-sans-first:23.11 06:17:17 INFO - PROCESS | 5861 | Values: 154.0 134.0 158.0 179.0 132.0 153.0 154.0 128.0 193.0 129.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.00 stddev:4.95 (3.1%) stddev-sans-first:5.21 06:17:17 INFO - PROCESS | 5861 | Values: 162.0 162.0 162.0 160.0 160.0 164.0 177.0 162.0 165.0 162.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#3] audio-fft Cycles:10 Average:92.80 Median:73.50 stddev:38.59 (52.5%) stddev-sans-first:40.26 06:17:17 INFO - PROCESS | 5861 | Values: 73.0 76.0 72.0 157.0 79.0 73.0 73.0 74.0 174.0 77.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.93 (30.4%) stddev-sans-first:28.88 06:17:17 INFO - PROCESS | 5861 | Values: 92.0 93.0 147.0 92.0 91.0 94.0 153.0 92.0 92.0 150.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:17:17 INFO - PROCESS | 5861 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 06:17:17 INFO - PROCESS | 5861 | Values: 148.0 147.0 147.0 145.0 146.0 147.0 146.0 145.0 147.0 146.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:17:17 INFO - PROCESS | 5861 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:5.03 (8.5%) stddev-sans-first:5.32 06:17:17 INFO - PROCESS | 5861 | Values: 59.0 60.0 59.0 59.0 61.0 58.0 57.0 74.0 56.0 60.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 06:17:17 INFO - PROCESS | 5861 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 58.0 58.0 58.0 58.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:1.35 (1.7%) stddev-sans-first:1.42 06:17:17 INFO - PROCESS | 5861 | Values: 78.0 76.0 78.0 77.0 77.0 77.0 77.0 78.0 81.0 77.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:127.00 stddev:22.21 (17.5%) stddev-sans-first:23.53 06:17:17 INFO - PROCESS | 5861 | Values: 130.0 124.0 134.0 124.0 124.0 123.0 121.0 123.0 195.0 133.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:3.12 (1.8%) stddev-sans-first:3.21 06:17:17 INFO - PROCESS | 5861 | Values: 168.0 168.0 171.0 172.0 177.0 172.0 168.0 171.0 169.0 166.0 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - PROCESS | 5861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:2.90 (4.1%) stddev-sans-first:2.39 06:17:17 INFO - PROCESS | 5861 | Values: 76.0 72.0 73.0 71.0 69.0 67.0 68.0 69.0 74.0 69.0 06:17:17 INFO - PROCESS | 5861 | -------- Summary: end -------- 06:17:17 INFO - PROCESS | 5861 | 06:17:17 INFO - TEST-INFO | 5861: exit 0 06:17:18 INFO - TEST-OK | kraken | took 61560ms 06:17:18 INFO - SUITE-END | took 1174s 06:17:18 INFO - Completed test suite (00:19:34) 06:17:18 INFO - javascript benchmark 06:17:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.9381412371754, 3152.243461569223, 3160.3047329587484, 3192.1700357906952, 3212.229065024395, 5169.715665638393, 5292.761825717847, 5293.417724050351, 5331.306930099091, 5347.304850369452, 5271.472852714736, 5287.180487024518, 5366.597505187116, 5413.918791218125, 5420.891582168354, 4772.403449568796, 4833.830815921444, 4861.173600487908, 4891.853244402656, 4934.432540257881, 819.6808291132892, 4679.3682852814945, 4766.094442056015, 4808.687435316693, 4816.422029356482, 4854.927176092361, 4874.049560335736, 4877.9268310975185, 4895.902081958358, 4922.729249891255, 4869.293952376921, 4901.558859702608, 4907.558319751204, 4910.1898186799135, 4940.530649588283, 4713.787879545429, 4756.0, 4807.807687692488, 4825.034993001379, 4873.195922672755, 5198.454162312941, 5199.220116982445, 5202.687838729688, 5213.53078222958, 5217.113090774577, 5560.888782224373, 5715.514181294553, 5722.284714410699, 5722.542196624302, 5723.941070901855, 5809.128630705386, 5844.883102337972, 5858.355580886099, 5861.472467477947, 5892.911606325909, 5359.437259087817, 5378.865528361783, 5381.865453363658, 5384.461553844623, 5396.514313711746, 5712.542996560265, 5867.237259156283, 5872.060470324813, 5888.4700376966275, 5891.528677705774, 5641.153826925994, 5642.181883626851, 5648.039833228361, 5650.26546548946, 5694.117411801178, 5711.828645140652, 5712.485876271156, 5715.057015592464, 5719.685417302005, 5729.312482502127, 5583.190437386556, 5681.403452637496, 5705.4579814917515, 5708.857278568069, 5748.856278592985, 5668.971655141698, 5723.685197314105, 5730.111832665943, 5731.054376027909, 5776.826695199151, 4332.025294308755, 4344.782760861945, 4381.211381951216, 4387.4954380246045, 4418.5802348776815, 3820.6370394812448, 3880.301545721797, 3952.110775075585, 3964.7819369934355, 3983.581723918947, 5305.602079844027, 5503.394626591072, 5556.277683901067, 5564.888702226014, 5590.301212348457, 5660.773569057192, 5716.971415142981, 5744.712764361849, 5746.856328591819, 5762.9135562966585, 5358.223057656696, 5418.187271909166, 5443.047466693392, 5516.393196748354, 5550.750216240279, 4756.881077973078, 4773.9761301193275, 4775.06886157196, 4788.736619485892, 4826.734529600835, 5996.490298324604, 6024.186734790835, 6036.607620504741, 6038.456538911519, 6043.214382130383, 5630.042892708249, 5714.514266287412, 5757.5393968481585, 5828.679422631796, 5863.560232982458, 5986.311574169026, 6005.039193728982, 6017.909731354121, 6018.458338749533, 6019.939800601938, 5673.602847800615, 5688.345840228427, 5691.630044047124, 5695.0603150481365, 5698.943010569841, 5644.887102258014, 5764.596478246483, 5834.241548598655, 5834.737436815439, 5888.440598143169, 5517.172424136412, 5579.442055794388, 5609.74756135983, 5610.382857885711, 5622.32532096151, 5519.806806761744, 5566.192902029264, 5566.805161819317, 5571.9442805571425, 5603.10350343943, 5523.6409633373705, 5546.168074788814, 5556.055470569932, 5595.412481689526, 5612.494875461228, 5623.2127502148915, 5635.633683810539, 5656.6888821115235, 5682.516986056232, 5687.8862422752145, 5460.0, 5557.083081291542, 5562.3881373048125, 5582.995060889079, 5605.775768969195], "value": 5255.24203050672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9772507962219, 650.9056186852906, 669.6952886436671, 670.5440300595593, 682.2938258902034, 37786.24427511451, 38926.41610375846, 39066.80466597666, 39089.21821563567, 39271.41092883609, 39726.0, 40331.0, 40434.39348409769, 40524.39213411801, 40706.185876282456, 8432.536210508435, 8585.399022068457, 8621.13788621139, 8648.956755216246, 8661.740147795575, 8509.0, 8563.700270490534, 8571.871421928676, 8768.868466973001, 8796.340274479408, 8746.562671866413, 8896.644134234622, 8899.510526921016, 8909.287257019423, 8934.0, 8800.075992020842, 8817.647294108228, 8863.556822158866, 8866.556672166365, 8883.600237989274, 8562.61468233931, 8639.65441382344, 8666.176713212235, 8686.782830429227, 8691.521966291852, 40358.192836143404, 40755.38866916999, 40800.0, 40898.1820363591, 40919.59080409217, 3643.8178091095338, 3699.9815000924823, 3766.077311058808, 3768.7550309229814, 3820.6752426043818, 31690.207744806336, 31861.0, 32059.35881282361, 32171.51742723861, 33448.66551334504, 4261.21167583998, 4271.97864010681, 4304.0, 4323.762193079411, 4381.868543943687, 261594.0, 262106.0, 262933.0, 265107.0, 265351.0, 33831.830840845636, 34209.31581368409, 57007.0, 57158.7142064287, 57597.0, 34692.826535867156, 34869.825650871586, 34902.476462853076, 34970.65029349674, 35114.0, 14991.100533967996, 15161.469348572748, 15167.696646067017, 15177.165255911032, 15248.085114893142, 13122.0, 13164.0, 13242.470301188037, 13246.602601921764, 13257.801132983013, 8434.662613495391, 8753.64985400577, 8803.723460098377, 8840.734777956543, 8888.955555222183, 3334.3998080345773, 3420.110771199506, 3422.9486557701653, 3470.479428085757, 3493.807840568793, 1080.5569716416232, 1088.5373716170595, 1189.3042570096418, 1213.4296880466343, 1220.9816852747215, 32079.099694432807, 32332.515012274835, 32450.188745281557, 32751.0, 33000.504992425136, 1155.4107405223397, 1277.0549793153, 1308.5584911682215, 1326.8938484921184, 1333.6932505523785, 16891.23989420479, 16965.15174241283, 17249.310027598756, 17626.5593360167, 17922.462326130237, 473071.0, 484797.0, 486199.0, 486815.0, 487877.0, 58679.0, 59120.0, 59199.70400147972, 59601.70199148977, 59829.40170598238, 1404.2206575350574, 1459.9854001459848, 1472.7054589082013, 1476.3946781819402, 1574.8976316539388, 33177.668223318426, 33283.500747488324, 33362.499562507066, 33657.49513757246, 33743.4938475928, 50494.2425863605, 51014.74492627513, 51281.23078153905, 51596.48403515917, 51640.22539661833, 434834.0, 435236.0, 439212.0, 439441.0, 441361.0, 28112.71887281101, 29226.56160157557, 29231.415371692874, 29239.122826315244, 29427.55858662079, 47681.0, 47751.0, 48138.75930620325, 48626.27060594023, 49277.507224928726, 37058.6294137066, 40300.0, 41945.58054419417, 42053.36919946264, 42353.364699530146, 37670.62329376671, 37881.62118378781, 37983.620163798005, 39397.0, 40686.0, 33243.16892077717, 37765.62234377621, 37872.0, 38551.807240963615, 41425.0, 32289.35421291608, 32465.925645067913, 35492.11269718174, 35879.282414351044, 36128.819355903055, 27809.860950695118, 28445.0, 28597.0, 28687.282817929718, 28764.712352876202], "value": 18726.35481062412, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.894458496206, 393.29403720322017, 400.43138742984956, 401.44600451377096, 401.5241938303113, 14034.157950522977, 16014.83985160148, 17759.112044397792, 18427.0, 18532.814671853277, 14625.195614241213, 17205.7419138713, 17220.13899305036, 17352.13239338031, 18601.7209741854, 5518.91721624176, 5538.307711536058, 5652.971735141318, 5678.545716342683, 5684.488396044355, 5542.584306177053, 5568.52667523259, 5630.465105814941, 5699.601027928046, 5699.8575035624235, 5412.485813847678, 5635.690037047961, 5654.321481422235, 5654.9151762723595, 5665.263515742948, 5574.470425309589, 5635.295588051494, 5655.519280861132, 5657.801976930808, 5661.264035675356, 4869.366982292315, 4975.378077740283, 5026.547610715053, 5042.369703787027, 5083.822066227664, 21641.783582164135, 22125.889370553043, 22499.77500224993, 22549.774502255095, 22568.66147007796, 2554.5912653975274, 2564.7691707746394, 2609.0, 2834.319763256824, 2852.001799370204, 14029.088109272865, 14224.502142424966, 14323.78514322286, 14460.421583136662, 14504.0, 1922.6250881078195, 1969.6454638165123, 2009.1963214714085, 2019.4446527204989, 2035.552178520738, 61359.0, 70916.29083709148, 72480.0, 75185.62407187984, 76423.61788191079, 10066.848997265048, 10436.63471778484, 10581.523831427605, 10702.518386672618, 10819.567217311376, 14685.0, 14697.118172909446, 14771.33528991198, 14787.556373308818, 14808.259587020606, 8137.918620813834, 8260.339172866277, 8280.089190189074, 8312.21034001769, 8420.031696354876, 8138.837223255502, 8227.753167404988, 8369.707060252862, 8383.455075420079, 8396.958015210008, 6326.746930122744, 6587.374199451045, 6594.142761441078, 6611.23970743361, 6690.5316627836555, 1910.6751852185162, 1954.1499447740277, 1979.8020197980086, 1987.4335814292858, 2008.8493362997542, 998.8052329795765, 1083.6748975307376, 1085.46812062089, 1086.5979587552656, 1116.7654792493504, 16982.57543561421, 18253.17860696272, 18381.908090459463, 18658.906705466656, 18843.29660467656, 1088.9727756806144, 1104.2215238257008, 1132.6092498088146, 1133.7335726104359, 1140.680609429361, 10868.293560918515, 11065.668029959113, 11098.334099954029, 11178.105751539857, 11182.273152245078, 484734.0, 499550.0, 500343.0, 501921.0, 550290.0, 79984.0, 84441.0, 84620.0, 85377.0, 87232.56383718041, 1083.2525557365393, 1085.0722632149398, 1090.825467925144, 1111.6387174168428, 1128.3681138562267, 16477.176141193133, 16757.32970681159, 16905.408310709066, 16953.74569381485, 17174.31302747926, 35377.646223537435, 37376.252474950896, 37447.43828842624, 37501.6249837509, 37956.43065353967, 48195.0, 48458.75770621125, 48645.0, 48890.51109488859, 49175.75412122916, 8239.794005149919, 8526.488410695378, 8542.701005464778, 8747.956260218658, 8861.158189971942, 11365.772684546428, 12602.180858244184, 13830.308484575933, 13889.444422222998, 13902.096363736326, 11826.645200643994, 11833.881661183623, 11885.405729713653, 11980.700482488008, 12144.939275303921, 11646.0, 11802.291862488279, 11825.645230643095, 12194.451249693962, 12199.390030498262, 12207.633770986884, 12239.69400764988, 12252.08109391817, 12261.570845020382, 12387.380630968595, 8695.739127826175, 8778.648854045767, 8780.604872780612, 8816.074312197126, 8910.777230569287, 10899.615113893327, 11758.823617645914, 11818.172727909308, 12184.817227741769, 12195.390230488263], "value": 9281.349201902398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.9466268680594, 1549.1324858079472, 1674.3051633572068, 1724.3188940368564, 1744.9738253926184, 7253.347198752112, 7440.144383395911, 7722.96138519308, 7734.419918506113, 7786.0, 7775.844483110334, 7799.493032952868, 7819.139894611588, 7827.060752709668, 7830.8042298942555, 2189.4854709143337, 2228.5988522066023, 2233.3076746208726, 2250.673652320421, 2260.977390226093, 2094.8847813370257, 2121.0, 2123.140128248062, 2141.2612648636195, 2196.9560608787815, 2192.188890110653, 2213.0373287619855, 2220.100859152046, 2231.7545070042283, 2235.3964429604, 2175.216921908112, 2182.0508078985613, 2184.2355175688463, 2187.201671389947, 2188.67169924511, 2195.7255343082115, 2218.1460137846884, 2227.042371780134, 2246.3148739634403, 2259.5029093599383, 7957.9204207957755, 7978.601069946538, 7991.120976692559, 8056.637451314705, 8062.395320350938, 4864.586510146642, 4967.205247160473, 5034.823781167678, 5042.117629414838, 5042.571381432583, 3180.634227063871, 3250.691184337484, 3356.7146792522667, 3360.6471320511237, 3396.9150771230916, 1103.906167975715, 1123.5337335005963, 1125.2404626876908, 1128.4470609401417, 1146.5299227316843, 10919.290246134055, 10966.780664386668, 10975.121990240841, 10977.560897564168, 10985.395803230898, 4324.870253892388, 4397.670174736843, 4449.9555004450185, 4477.2164871147415, 4549.522300158502, 9364.110409511086, 9430.915444723807, 9436.90563094374, 9439.433633981984, 9479.24166066713, 4964.1809101498575, 4969.975150124226, 4971.105201063771, 4972.801087956514, 4992.026554821848, 4149.107941792468, 4490.932636010462, 4506.887327816765, 4633.745144017112, 4643.6517261205545, 3722.9813850930573, 3808.8857334280015, 3825.3496905526126, 3845.8461661533224, 3861.768293902375, 1210.7820592293297, 1219.3842109734528, 1243.3286025546286, 1247.2828123828835, 1247.9563215287421, 905.3300557587338, 1010.6361709784471, 1035.7980193862124, 1048.8112139814755, 1066.4134725900724, 5567.777288908479, 5713.05734553794, 5806.666434744627, 5806.796762113306, 5881.5588830837005, 481.14836738971826, 482.9082474329866, 483.995160048395, 1037.9325343852624, 1088.1349327284827, 3908.394198899175, 3949.624785645359, 3984.8406063757125, 3999.8400063997697, 4039.4546736190237, 9658.468784216795, 9993.600255989679, 10028.498575071217, 10077.748056298651, 10078.949605252074, 9868.555914983843, 9929.0, 9968.950155249177, 9979.80040399188, 9987.900120998696, 7420.628968551551, 7528.849423011509, 7621.780515117554, 7742.845143097106, 7768.572728499987, 5685.488306052475, 5703.771849126155, 5818.359980402068, 5832.825015249549, 5881.264841894763, 8952.373333866566, 9092.545372731469, 9138.497382644018, 9158.725238242863, 9176.632934682804, 9084.636614535344, 9209.815803683754, 9234.9538252311, 9499.572519236513, 9500.809983800424, 6460.547761656639, 6703.865922681616, 6841.828954276183, 6909.205441374306, 7010.404115650227, 8093.352531797324, 8121.796955075934, 8122.268995790408, 8145.144759800372, 8162.510249385056, 7055.541389809646, 7089.361957423856, 7231.16841563227, 7240.312170343809, 7400.888986665097, 6967.930320696728, 7035.929640703527, 7039.401650859734, 7079.539829911039, 7110.431165506644, 6573.737050518117, 6693.397594216543, 6705.2959439258175, 6721.93278067213, 6725.4619630430425, 4832.830850920201, 4868.634852386156, 4875.658703890694, 4878.975605121952, 4912.582430493448, 5094.592432605456, 5094.719790411415, 5096.949030509796, 5097.464766199644, 5171.043356978971], "value": 4357.751982675261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.982455964922, 319.257725787544, 320.1500017453661, 325.20811823210477, 335.9848806803694, 5356.330458692663, 5484.7531861066245, 5525.640833345829, 5525.850265348753, 5527.364353099395, 5413.350397952241, 5439.755211015504, 5441.483059109388, 5445.346558412996, 5470.9452905471035, 4014.919701605966, 4078.0416602098485, 4221.387898754679, 4223.598758117989, 4230.513490948534, 4218.894527636819, 4232.217039847638, 4245.915081698379, 4253.425787518692, 4256.957045523851, 4156.482883747425, 4174.77038762868, 4204.1801848639525, 4213.136307057046, 4215.093754842708, 4062.289099407592, 4136.958630413687, 4162.146759914225, 4177.4569305990335, 4214.599613036757, 3659.981700091509, 3666.4683620874825, 3668.192997540537, 3679.5768486624115, 3688.5389326334207, 5232.973835130838, 5255.132903071027, 5275.129603615399, 5289.153735402356, 5307.363116426015, 4779.61763058958, 4845.394325709286, 4854.538818812207, 4862.7325497097645, 4908.288298196777, 5664.660120392789, 5666.773329066832, 5686.232358631614, 5719.370869204384, 5798.449147330997, 4127.731697439657, 4130.63688982638, 4135.152293779798, 4148.8133034013545, 4162.666986641061, 5807.390224026459, 5944.335586035917, 5976.62320788753, 5984.760609575612, 6011.458968692838, 4183.937240941388, 4195.265828480004, 4203.222403855297, 4236.2252724465525, 4256.765877876746, 4286.428143114106, 4302.65578753699, 4314.180305741962, 4315.611594956469, 4323.0705398339505, 4555.931661025087, 4836.806527738921, 4885.902281954341, 4897.1674815281485, 4912.0, 5742.511886489611, 5781.19063331134, 5781.479666830005, 5786.450287222707, 5802.593818432669, 1508.1403599948144, 1512.6520900193018, 1515.674130062042, 1519.2100107943807, 1521.680447106098, 953.4660590069583, 990.0198803184795, 992.2905122837207, 1028.1517747858047, 1036.0261354326908, 5891.116332550066, 5957.106434034929, 5958.344582095966, 5992.520598352121, 5992.880142397127, 6181.84545386369, 6281.528885333527, 6311.621302721851, 6328.6202827830475, 6333.334999825044, 5328.440513746001, 5635.323761148688, 5648.0, 5673.744681489343, 5962.880742385128, 3409.4203985322556, 3417.7778444401033, 3421.3499435107747, 3437.553118094682, 3439.9656003439645, 6478.838029049311, 6631.0, 6646.26891041985, 6670.899936500957, 6693.0, 6529.738810447624, 6536.738530458823, 6553.672316384162, 6565.507586930999, 6592.406683398422, 6551.770688025897, 6617.9669101655145, 6626.138601981808, 6652.8669426611195, 6676.798176328308, 6407.935920640734, 6411.166548348685, 6420.6789660517725, 6437.388448097423, 6462.3537646235, 6188.81433556994, 6275.52933529978, 6282.842928926813, 6283.837490064353, 6321.209848768904, 6457.67711614408, 6684.398404143651, 6685.364890335411, 6716.496262780213, 6746.561473504403, 4285.91428171441, 4358.891027724332, 4380.255356589324, 4384.978075109604, 4387.451568553931, 6212.502999760099, 6370.585911915896, 6418.138739765416, 6430.485561155003, 6459.128017717736, 6231.75072997075, 6242.219722534684, 6245.594036387621, 6247.281562620356, 6247.375262473898, 6091.147239386578, 6188.597741146811, 6200.596961197508, 6233.812985610439, 6272.529560282906, 5434.483724046209, 5444.564434845282, 5721.771129154788, 6139.662318572521, 6158.706671599014, 5794.739236734273, 5804.303483581997, 5806.5645076618575, 5824.504917082096, 5846.707664616667, 5584.636998595079, 5681.9147712783515, 5683.829485115453, 5690.3456102548735, 5701.522071536277], "value": 4506.307956328201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.8925545051418, 820.9384296177789, 869.7738587967131, 879.9340049496285, 885.4465958775766, 14866.47967321144, 15254.23728813559, 15465.226738663065, 15988.84011159888, 16638.50084497464, 15169.393224271043, 15194.924025379885, 15244.618884527892, 15303.69392612147, 15332.61668458289, 704.2921863527148, 817.2236375443323, 827.1191181391829, 829.1832544943256, 844.8690452979768, 845.2181731898, 847.6524624903791, 852.2415050604935, 854.2055888024136, 854.3976496569934, 887.5828360670507, 889.6263569300909, 890.9242714369286, 893.2139717049021, 895.0467751844297, 881.4094556647062, 883.659790980474, 884.0982198157875, 884.9115088491163, 887.3389324952919, 629.1003864473801, 641.8138739765462, 643.0771842406162, 644.9097126402307, 650.4893658478072, 14978.325975331136, 15044.473443429428, 15063.397464101423, 15089.924550377287, 15091.0, 13875.236861972588, 14130.081544699664, 14287.214203218819, 14298.28508574567, 14384.64038399038, 11941.641750747405, 11975.94012029943, 12048.156629035971, 12104.092193085466, 12189.451474683661, 3880.6715970417804, 3894.357431023878, 3912.2371137628174, 3939.5469521005166, 3965.6034396560403, 53718.194227086235, 62645.74708505804, 62708.37291627071, 62784.0, 63075.0, 11352.0, 11374.54501819918, 11417.029552488131, 11467.369294688706, 11484.483198256099, 19120.61758764845, 19155.425337239903, 19269.61460770777, 19280.0, 19323.4202973911, 8548.401611887108, 8655.523946182895, 8655.56722163902, 8682.479051256945, 8760.0, 4672.322513235562, 4699.976500117477, 4727.881802954954, 4744.4350800654265, 4855.660103792771, 3353.2622822978906, 3449.448088305909, 3450.9827450862585, 3473.0622731862254, 3475.2354482013916, 649.1074772188241, 652.1619718661498, 653.2977049671528, 659.8317429055656, 660.4947215380238, 706.8515611721596, 724.3119036914952, 773.6866569039548, 777.6150805351388, 790.517784151667, 9050.922686286694, 9636.46999415039, 9720.368176068532, 9739.756506087404, 9893.554790034466, 641.8074577626787, 722.2957616324042, 722.9674664640104, 736.7568702328219, 772.9304362607393, 4547.795349209294, 4627.167109920179, 4630.768461576975, 4647.535246475393, 4656.953430465652, 57178.7141064292, 57887.421125788205, 59342.40657593369, 59448.70275648594, 60909.390906091256, 55747.72126139343, 57215.71392143013, 57330.713346433, 58064.70967645219, 58333.0, 47984.5201547987, 50300.748496257285, 53981.46018539764, 55701.0, 56194.71902640461, 9651.9034809651, 9755.951220243853, 9767.267454940766, 9800.781755070038, 9828.655997040069, 33954.83022584871, 34358.65641343655, 34934.82532587321, 35539.28921421505, 35560.64439355573, 42822.571774283104, 44833.55166448294, 45792.08415831732, 45855.77072114618, 46248.30627540657, 12379.257244565355, 12600.621981340575, 12672.936635316764, 12700.0, 12939.741205175655, 13947.16317020982, 14296.857031429552, 14550.85449145495, 14616.70766584641, 14978.775318370015, 12757.127750842797, 12892.226466412045, 12904.677383065498, 13316.46734130624, 13505.797413038616, 13002.934985325013, 13535.72928541404, 13561.79657305161, 13614.38735256896, 13831.792523112363, 11572.0, 13260.270685112026, 13315.733685326046, 13354.332283385986, 14130.293485325898, 11070.889291106985, 11071.50178241965, 11327.490262938023, 11344.149188811038, 11517.424128793695, 11377.601783937522, 11379.658610241706, 11467.713307167387, 11612.361320127475, 11658.88341116612], "value": 7038.101301745819, "unit": "score"}], "name": "dromaeo_css", "value": 7082.823255622011, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 113.0, 112.0, 124.0, 112.0, 113.0, 111.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 134.0, 158.0, 179.0, 132.0, 153.0, 154.0, 128.0, 193.0, 129.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 160.0, 164.0, 177.0, 162.0, 165.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 72.0, 157.0, 79.0, 73.0, 73.0, 74.0, 174.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 147.0, 92.0, 91.0, 94.0, 153.0, 92.0, 92.0, 150.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 58.0, 57.0, 74.0, 56.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 81.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 134.0, 124.0, 124.0, 123.0, 121.0, 123.0, 195.0, 133.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 171.0, 172.0, 177.0, 172.0, 168.0, 171.0, 169.0, 166.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 73.0, 71.0, 69.0, 67.0, 68.0, 69.0, 74.0, 69.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1561.1999999999996, "alertThreshold": 2.0}]} 06:17:18 INFO - Return code: 0 06:17:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:18 ERROR - # TBPL SUCCESS # 06:17:18 INFO - Running post-action listener: _resource_record_post_action 06:17:18 INFO - Running post-run listener: _resource_record_post_run 06:17:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 499712; Write bytes: 360624128; Read time: 80; Write time: 386340 06:17:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 74989568; Read time: 0; Write time: 61564 06:17:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 499712; Write bytes: 285634560; Read time: 80; Write time: 324776 06:17:19 INFO - Running post-run listener: _upload_blobber_files 06:17:19 INFO - Blob upload gear active. 06:17:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:19 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 06:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:20 INFO - (blobuploader) - INFO - Done attempting. 06:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:21 INFO - (blobuploader) - INFO - Done attempting. 06:17:21 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:21 INFO - Return code: 0 06:17:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/385dcce13bb83b7b4f364e736d0c4fe11354b3dd4efb299c3f85e6c0bf8be2f8c76f54fbb8205072b37f45d909bc5f775720ae7fe8e0d67462a0551d4f001c7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70406d1bbe3d129914e8bf26e8b5b1ecdb401bc13e72b32150907a5899ed34fdeecc8e984f8c40f1ef7708b0400b24211cff2c4fc28c15e9a2289393406af777"} 06:17:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:21 INFO - Contents: 06:17:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/385dcce13bb83b7b4f364e736d0c4fe11354b3dd4efb299c3f85e6c0bf8be2f8c76f54fbb8205072b37f45d909bc5f775720ae7fe8e0d67462a0551d4f001c7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70406d1bbe3d129914e8bf26e8b5b1ecdb401bc13e72b32150907a5899ed34fdeecc8e984f8c40f1ef7708b0400b24211cff2c4fc28c15e9a2289393406af777"} 06:17:21 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:21 INFO - Copying logs to upload dir... 06:17:21 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.065729 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-05 06:17:21.807924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:21.816902) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/385dcce13bb83b7b4f364e736d0c4fe11354b3dd4efb299c3f85e6c0bf8be2f8c76f54fbb8205072b37f45d909bc5f775720ae7fe8e0d67462a0551d4f001c7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70406d1bbe3d129914e8bf26e8b5b1ecdb401bc13e72b32150907a5899ed34fdeecc8e984f8c40f1ef7708b0400b24211cff2c4fc28c15e9a2289393406af777"} build_url:https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/fH969QQkQgWbRptI3AyzpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/385dcce13bb83b7b4f364e736d0c4fe11354b3dd4efb299c3f85e6c0bf8be2f8c76f54fbb8205072b37f45d909bc5f775720ae7fe8e0d67462a0551d4f001c7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70406d1bbe3d129914e8bf26e8b5b1ecdb401bc13e72b32150907a5899ed34fdeecc8e984f8c40f1ef7708b0400b24211cff2c4fc28c15e9a2289393406af777"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:21.844134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:21.844484) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1462452792.87140-771643009 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 06:17:21.894411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 06:17:21.894731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 06:17:21.895066) ========= ========= Total master_lag: 0.26 =========