builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1460637922.84 results: success (0) buildid: 20160414030247 builduid: 429190adabdc4754941ed0e71a4d0cdb revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:22.835997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:22.836854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:22.837153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.212769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.213157) ========= 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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 05:45:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-04-14 05:45:23 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.395141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.395458) ========= 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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023030 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.628087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:23.628449) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91115264629dfaacf2d60d52a3eff89c18c5af0d --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 91115264629dfaacf2d60d52a3eff89c18c5af0d --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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 05:45:24,011 truncating revision to first 12 chars 2016-04-14 05:45:24,011 Setting DEBUG logging. 2016-04-14 05:45:24,011 attempt 1/10 2016-04-14 05:45:24,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91115264629d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 05:45:24,260 unpacking tar archive at: mozilla-central-91115264629d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:24.163887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:24.164209) ========= script_repo_revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:24.164611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:24.164889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:45:24.174556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-14 05:45:24.174837) ========= /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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:24 INFO - MultiFileLogger online at 20160414 05:45:24 in /builds/slave/test 05:45:24 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:45:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:24 INFO - {'append_to_log': False, 05:45:24 INFO - 'base_work_dir': '/builds/slave/test', 05:45:24 INFO - 'blob_upload_branch': 'Firefox', 05:45:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:24 INFO - 'branch': 'Firefox', 05:45:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:24 INFO - 'config_files': ('talos/linux_config.py',), 05:45:24 INFO - 'default_actions': ('clobber', 05:45:24 INFO - 'read-buildbot-config', 05:45:24 INFO - 'download-and-extract', 05:45:24 INFO - 'populate-webroot', 05:45:24 INFO - 'create-virtualenv', 05:45:24 INFO - 'install', 05:45:24 INFO - 'run-tests'), 05:45:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:24 INFO - 'download_minidump_stackwalk': True, 05:45:24 INFO - 'download_symbols': 'ondemand', 05:45:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:24 INFO - 'installer_path': 'installer.exe', 05:45:24 INFO - 'log_level': 'info', 05:45:24 INFO - 'log_name': 'talos', 05:45:24 INFO - 'log_to_console': True, 05:45:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:24 INFO - 'opt_config_files': (), 05:45:24 INFO - 'pip_index': False, 05:45:24 INFO - 'sps_profile': False, 05:45:24 INFO - 'sps_profile_interval': 0, 05:45:24 INFO - 'suite': 'dromaeojs-e10s', 05:45:24 INFO - 'system_bits': '32', 05:45:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:24 INFO - 'title': 'talos-linux64-ix-020', 05:45:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:24 INFO - 'use_talos_json': True, 05:45:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:24 INFO - 'work_dir': 'build'} 05:45:24 INFO - ##### 05:45:24 INFO - ##### Running clobber step. 05:45:24 INFO - ##### 05:45:24 INFO - Running pre-action listener: _resource_record_pre_action 05:45:24 INFO - Running main action method: clobber 05:45:24 INFO - rmtree: /builds/slave/test/build 05:45:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running read-buildbot-config step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: read_buildbot_config 05:45:25 INFO - Using buildbot properties: 05:45:25 INFO - { 05:45:25 INFO - "project": "", 05:45:25 INFO - "product": "firefox", 05:45:25 INFO - "script_repo_revision": "production", 05:45:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:25 INFO - "repository": "", 05:45:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:45:25 INFO - "buildid": "20160414030247", 05:45:25 INFO - "stage_platform": "linux64-pgo", 05:45:25 INFO - "basedir": "/builds/slave/test", 05:45:25 INFO - "nightly_build": "True", 05:45:25 INFO - "buildnumber": 698, 05:45:25 INFO - "slavename": "talos-linux64-ix-020", 05:45:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:25 INFO - "platform": "ubuntu64_hw", 05:45:25 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:25 INFO - "branch": "mozilla-central", 05:45:25 INFO - "repo_path": "mozilla-central", 05:45:25 INFO - "revision": "91115264629dfaacf2d60d52a3eff89c18c5af0d", 05:45:25 INFO - "pgo_build": "True", 05:45:25 INFO - "builduid": "429190adabdc4754941ed0e71a4d0cdb", 05:45:25 INFO - "slavebuilddir": "test" 05:45:25 INFO - } 05:45:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running download-and-extract step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: download_and_extract 05:45:25 INFO - mkdir: /builds/slave/test/build/tests 05:45:25 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:45:25 INFO - https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:45:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:45:30 INFO - Downloaded 1361 bytes. 05:45:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:30 INFO - Using the following test package requirements: 05:45:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'jsshell-linux-x86_64.zip'], 05:45:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:30 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:45:30 INFO - https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:35 INFO - Downloaded 23774682 bytes. 05:45:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:36 INFO - Return code: 0 05:45:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:45: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:45:36 INFO - https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:38 INFO - Downloaded 23774682 bytes. 05:45:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:39 INFO - Return code: 0 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:45:40 INFO - Downloaded 10841076 bytes. 05:45:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:45:41 INFO - Return code: 0 05:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:45:41 INFO - https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:45:42 INFO - Downloaded 58146398 bytes. 05:45:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:42 INFO - mkdir: /builds/slave/test/properties 05:45:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:42 INFO - Contents: 05:45:42 INFO - build_url:https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:45:43 INFO - Running post-action listener: _resource_record_post_action 05:45:43 INFO - Running post-action listener: set_extra_try_arguments 05:45:43 INFO - ##### 05:45:43 INFO - ##### Running populate-webroot step. 05:45:43 INFO - ##### 05:45:43 INFO - Running pre-action listener: _resource_record_pre_action 05:45:43 INFO - Running main action method: populate_webroot 05:45:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:43 INFO - '--tppagecycles', 05:45:43 INFO - '7'], 05:45:43 INFO - 'tests': ['tsvgm']}}, 05:45:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['damp', 'tps']}, 05:45:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'tests': ['damp', 'tps']}, 05:45:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['dromaeo_dom']}, 05:45:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['a11yr', 05:45:43 INFO - 'ts_paint', 05:45:43 INFO - 'tpaint', 05:45:43 INFO - 'sessionrestore', 05:45:43 INFO - 'sessionrestore_no_auto_restore', 05:45:43 INFO - 'tabpaint']}, 05:45:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['tsvgx', 05:45:43 INFO - 'tsvgr_opacity', 05:45:43 INFO - 'tart', 05:45:43 INFO - 'tscrollx', 05:45:43 INFO - 'cart']}, 05:45:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:43 INFO - 'tsvgr_opacity', 05:45:43 INFO - 'tart', 05:45:43 INFO - 'tscrollx', 05:45:43 INFO - 'cart']}, 05:45:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'talos_options': ['--disable-e10s'], 05:45:43 INFO - 'tests': ['tp5o']}, 05:45:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'tests': ['tp5o']}, 05:45:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'talos_options': ['--disable-e10s', 05:45:43 INFO - '--xperf_path', 05:45:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:43 INFO - 'tests': ['tp5n']}, 05:45:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:43 INFO - 'talos_options': ['--xperf_path', 05:45:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:43 INFO - 'tests': ['tp5n']}}, 05:45:43 INFO - 'talos.zip': {'path': '', 05:45:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:43 INFO - Running post-action listener: _resource_record_post_action 05:45:43 INFO - ##### 05:45:43 INFO - ##### Running create-virtualenv step. 05:45:43 INFO - ##### 05:45:43 INFO - Running pre-action listener: _resource_record_pre_action 05:45:43 INFO - Running main action method: create_virtualenv 05:45:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:43 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:45:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:43 INFO - Using real prefix '/usr' 05:45:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:45 INFO - Installing pip.................done. 05:45:45 INFO - Return code: 0 05:45:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:45 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:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 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:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:45 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:45 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:45:45 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:45:45 INFO - Using env: {'DISPLAY': ':0', 05:45:45 INFO - 'HOME': '/home/cltbld', 05:45:45 INFO - 'LANG': 'en_US.UTF-8', 05:45:45 INFO - 'LANGUAGE': 'en_US:en', 05:45:45 INFO - 'LOGNAME': 'cltbld', 05:45:45 INFO - 'MAIL': '/var/mail/cltbld', 05:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:45 INFO - 'MOZ_NO_REMOTE': '1', 05:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:45 INFO - 'NO_EM_RESTART': '1', 05:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:45 INFO - 'PWD': '/builds/slave/test', 05:45:45 INFO - 'SHELL': '/bin/bash', 05:45:45 INFO - 'SHLVL': '1', 05:45:45 INFO - 'TERM': 'linux', 05:45:45 INFO - 'TMOUT': '86400', 05:45:45 INFO - 'USER': 'cltbld', 05:45:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:45 INFO - '_': '/tools/buildbot/bin/python'} 05:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:46 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:45:46 INFO - Cleaning up... 05:45:46 INFO - Return code: 0 05:45:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:46 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:46 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:45:46 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:45:46 INFO - Using env: {'DISPLAY': ':0', 05:45:46 INFO - 'HOME': '/home/cltbld', 05:45:46 INFO - 'LANG': 'en_US.UTF-8', 05:45:46 INFO - 'LANGUAGE': 'en_US:en', 05:45:46 INFO - 'LOGNAME': 'cltbld', 05:45:46 INFO - 'MAIL': '/var/mail/cltbld', 05:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:46 INFO - 'MOZ_NO_REMOTE': '1', 05:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:46 INFO - 'NO_EM_RESTART': '1', 05:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:46 INFO - 'PWD': '/builds/slave/test', 05:45:46 INFO - 'SHELL': '/bin/bash', 05:45:46 INFO - 'SHLVL': '1', 05:45:46 INFO - 'TERM': 'linux', 05:45:46 INFO - 'TMOUT': '86400', 05:45:46 INFO - 'USER': 'cltbld', 05:45:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:46 INFO - '_': '/tools/buildbot/bin/python'} 05:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:46 INFO - Downloading/unpacking psutil>=0.7.1 05:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:48 INFO - Installing collected packages: psutil 05:45:48 INFO - Running setup.py install for psutil 05:45:48 INFO - building 'psutil._psutil_linux' extension 05:45:48 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:45:48 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:45:48 INFO - building 'psutil._psutil_posix' extension 05:45:48 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:45:48 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:45:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:48 INFO - Successfully installed psutil 05:45:48 INFO - Cleaning up... 05:45:48 INFO - Return code: 0 05:45:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:48 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:45:48 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:45:48 INFO - Using env: {'DISPLAY': ':0', 05:45:48 INFO - 'HOME': '/home/cltbld', 05:45:48 INFO - 'LANG': 'en_US.UTF-8', 05:45:48 INFO - 'LANGUAGE': 'en_US:en', 05:45:48 INFO - 'LOGNAME': 'cltbld', 05:45:48 INFO - 'MAIL': '/var/mail/cltbld', 05:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:48 INFO - 'MOZ_NO_REMOTE': '1', 05:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:48 INFO - 'NO_EM_RESTART': '1', 05:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:48 INFO - 'PWD': '/builds/slave/test', 05:45:48 INFO - 'SHELL': '/bin/bash', 05:45:48 INFO - 'SHLVL': '1', 05:45:48 INFO - 'TERM': 'linux', 05:45:48 INFO - 'TMOUT': '86400', 05:45:48 INFO - 'USER': 'cltbld', 05:45:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:48 INFO - '_': '/tools/buildbot/bin/python'} 05:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:50 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:45:50 INFO - Installing collected packages: mozsystemmonitor 05:45:50 INFO - Running setup.py install for mozsystemmonitor 05:45:51 INFO - Successfully installed mozsystemmonitor 05:45:51 INFO - Cleaning up... 05:45:51 INFO - Return code: 0 05:45:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:51 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:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 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:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:51 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:45:51 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:45:51 INFO - Using env: {'DISPLAY': ':0', 05:45:51 INFO - 'HOME': '/home/cltbld', 05:45:51 INFO - 'LANG': 'en_US.UTF-8', 05:45:51 INFO - 'LANGUAGE': 'en_US:en', 05:45:51 INFO - 'LOGNAME': 'cltbld', 05:45:51 INFO - 'MAIL': '/var/mail/cltbld', 05:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:51 INFO - 'MOZ_NO_REMOTE': '1', 05:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:51 INFO - 'NO_EM_RESTART': '1', 05:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:51 INFO - 'PWD': '/builds/slave/test', 05:45:51 INFO - 'SHELL': '/bin/bash', 05:45:51 INFO - 'SHLVL': '1', 05:45:51 INFO - 'TERM': 'linux', 05:45:51 INFO - 'TMOUT': '86400', 05:45:51 INFO - 'USER': 'cltbld', 05:45:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:51 INFO - '_': '/tools/buildbot/bin/python'} 05:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:53 INFO - Downloading docopt-0.6.1.tar.gz 05:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:53 INFO - Running setup.py install for blobuploader 05:45:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:54 INFO - Running setup.py install for requests 05:45:54 INFO - Running setup.py install for docopt 05:45:54 INFO - Successfully installed blobuploader requests docopt 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:54 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:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:54 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:45:54 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:45:54 INFO - Using env: {'DISPLAY': ':0', 05:45:54 INFO - 'HOME': '/home/cltbld', 05:45:54 INFO - 'LANG': 'en_US.UTF-8', 05:45:54 INFO - 'LANGUAGE': 'en_US:en', 05:45:54 INFO - 'LOGNAME': 'cltbld', 05:45:54 INFO - 'MAIL': '/var/mail/cltbld', 05:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:54 INFO - 'MOZ_NO_REMOTE': '1', 05:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:54 INFO - 'NO_EM_RESTART': '1', 05:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:54 INFO - 'PWD': '/builds/slave/test', 05:45:54 INFO - 'SHELL': '/bin/bash', 05:45:54 INFO - 'SHLVL': '1', 05:45:54 INFO - 'TERM': 'linux', 05:45:54 INFO - 'TMOUT': '86400', 05:45:54 INFO - 'USER': 'cltbld', 05:45:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:54 INFO - '_': '/tools/buildbot/bin/python'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:54 INFO - Running setup.py (path:/tmp/pip-h2BjZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:54 INFO - Running setup.py (path:/tmp/pip-u8oaNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:54 INFO - Running setup.py (path:/tmp/pip-LIGG6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:54 INFO - Running setup.py (path:/tmp/pip-EKxsCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:55 INFO - Running setup.py (path:/tmp/pip-84T27d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:55 INFO - Running setup.py (path:/tmp/pip-5o68Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:55 INFO - Running setup.py (path:/tmp/pip-4kG3kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:55 INFO - Running setup.py (path:/tmp/pip-CVARtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:55 INFO - Running setup.py (path:/tmp/pip-2YvvtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:55 INFO - Running setup.py (path:/tmp/pip-Dg9egI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:55 INFO - Running setup.py (path:/tmp/pip-bAWzaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:55 INFO - Running setup.py (path:/tmp/pip-JViDVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:55 INFO - Running setup.py (path:/tmp/pip-vUYpvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:55 INFO - Running setup.py (path:/tmp/pip-r8HrvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:55 INFO - Running setup.py (path:/tmp/pip-JbaWC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:55 INFO - Running setup.py (path:/tmp/pip-DNrv9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:55 INFO - Running setup.py (path:/tmp/pip-lqIjlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:55 INFO - Running setup.py install for manifestparser 05:45:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Running setup.py install for mozcrash 05:45:56 INFO - Running setup.py install for mozdebug 05:45:56 INFO - Running setup.py install for mozdevice 05:45:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Running setup.py install for mozfile 05:45:56 INFO - Running setup.py install for mozhttpd 05:45:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Running setup.py install for mozinfo 05:45:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Running setup.py install for mozInstall 05:45:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:56 INFO - Running setup.py install for mozleak 05:45:56 INFO - Running setup.py install for mozlog 05:45:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Running setup.py install for moznetwork 05:45:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Running setup.py install for mozprocess 05:45:57 INFO - Running setup.py install for mozprofile 05:45:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Running setup.py install for mozrunner 05:45:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Running setup.py install for mozscreenshot 05:45:57 INFO - Running setup.py install for moztest 05:45:57 INFO - Running setup.py install for mozversion 05:45:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:57 INFO - Cleaning up... 05:45:57 INFO - Return code: 0 05:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45: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:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:57 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:45:57 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:45:57 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:45:57 INFO - Using env: {'DISPLAY': ':0', 05:45:57 INFO - 'HOME': '/home/cltbld', 05:45:57 INFO - 'LANG': 'en_US.UTF-8', 05:45:57 INFO - 'LANGUAGE': 'en_US:en', 05:45:57 INFO - 'LOGNAME': 'cltbld', 05:45:57 INFO - 'MAIL': '/var/mail/cltbld', 05:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:57 INFO - 'MOZ_NO_REMOTE': '1', 05:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:57 INFO - 'NO_EM_RESTART': '1', 05:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:57 INFO - 'PWD': '/builds/slave/test', 05:45:57 INFO - 'SHELL': '/bin/bash', 05:45:57 INFO - 'SHLVL': '1', 05:45:57 INFO - 'TERM': 'linux', 05:45:57 INFO - 'TMOUT': '86400', 05:45:57 INFO - 'USER': 'cltbld', 05:45:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:57 INFO - '_': '/tools/buildbot/bin/python'} 05:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:58 INFO - Running setup.py (path:/tmp/pip-2hpuv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:58 INFO - Running setup.py (path:/tmp/pip-1kMi8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:58 INFO - Running setup.py (path:/tmp/pip-UdIjBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:58 INFO - Running setup.py (path:/tmp/pip-b3KjR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:58 INFO - Running setup.py (path:/tmp/pip-GqY2kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:58 INFO - Running setup.py (path:/tmp/pip-VMHvKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:58 INFO - Running setup.py (path:/tmp/pip-tMnpG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:58 INFO - Running setup.py (path:/tmp/pip-cmPHlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:58 INFO - Running setup.py (path:/tmp/pip-ykpAHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:58 INFO - Running setup.py (path:/tmp/pip-lr18ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:58 INFO - Running setup.py (path:/tmp/pip-mQmrKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:58 INFO - Running setup.py (path:/tmp/pip-FVPMFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:58 INFO - Running setup.py (path:/tmp/pip-5B9Afh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:58 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:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:58 INFO - Running setup.py (path:/tmp/pip-WLDZh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:59 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:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:59 INFO - Running setup.py (path:/tmp/pip-jiT1N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:59 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:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:59 INFO - Running setup.py (path:/tmp/pip-ZHXs36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:59 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:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:59 INFO - Running setup.py (path:/tmp/pip-6MGS9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:46:01 INFO - Downloading blessings-1.6.tar.gz 05:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:01 INFO - Installing collected packages: blessings 05:46:01 INFO - Running setup.py install for blessings 05:46:01 INFO - Successfully installed blessings 05:46:01 INFO - Cleaning up... 05:46:01 INFO - Return code: 0 05:46:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:01 INFO - Reading from file tmpfile_stdout 05:46:01 INFO - Current package versions: 05:46:01 INFO - argparse == 1.2.1 05:46:01 INFO - blessings == 1.6 05:46:01 INFO - blobuploader == 1.2.4 05:46:01 INFO - docopt == 0.6.1 05:46:01 INFO - manifestparser == 1.1 05:46:01 INFO - mozInstall == 1.12 05:46:01 INFO - mozcrash == 0.17 05:46:01 INFO - mozdebug == 0.1 05:46:01 INFO - mozdevice == 0.48 05:46:01 INFO - mozfile == 1.2 05:46:01 INFO - mozhttpd == 0.7 05:46:01 INFO - mozinfo == 0.9 05:46:01 INFO - mozleak == 0.1 05:46:01 INFO - mozlog == 3.1 05:46:01 INFO - moznetwork == 0.27 05:46:01 INFO - mozprocess == 0.22 05:46:01 INFO - mozprofile == 0.28 05:46:01 INFO - mozrunner == 6.11 05:46:01 INFO - mozscreenshot == 0.1 05:46:01 INFO - mozsystemmonitor == 0.0 05:46:01 INFO - moztest == 0.7 05:46:01 INFO - mozversion == 1.4 05:46:01 INFO - psutil == 3.1.1 05:46:01 INFO - requests == 1.2.3 05:46:01 INFO - wsgiref == 0.1.2 05:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 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 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:46:01 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:46:01 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:46:01 INFO - Using env: {'DISPLAY': ':0', 05:46:01 INFO - 'HOME': '/home/cltbld', 05:46:01 INFO - 'LANG': 'en_US.UTF-8', 05:46:01 INFO - 'LANGUAGE': 'en_US:en', 05:46:01 INFO - 'LOGNAME': 'cltbld', 05:46:01 INFO - 'MAIL': '/var/mail/cltbld', 05:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:01 INFO - 'MOZ_NO_REMOTE': '1', 05:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:01 INFO - 'NO_EM_RESTART': '1', 05:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:01 INFO - 'PWD': '/builds/slave/test', 05:46:01 INFO - 'SHELL': '/bin/bash', 05:46:01 INFO - 'SHLVL': '1', 05:46:01 INFO - 'TERM': 'linux', 05:46:01 INFO - 'TMOUT': '86400', 05:46:01 INFO - 'USER': 'cltbld', 05:46:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:01 INFO - '_': '/tools/buildbot/bin/python'} 05:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 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:46:01 INFO - Cleaning up... 05:46:01 INFO - Return code: 0 05:46:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:01 INFO - Using env: {'DISPLAY': ':0', 05:46:01 INFO - 'HOME': '/home/cltbld', 05:46:01 INFO - 'LANG': 'en_US.UTF-8', 05:46:01 INFO - 'LANGUAGE': 'en_US:en', 05:46:01 INFO - 'LOGNAME': 'cltbld', 05:46:01 INFO - 'MAIL': '/var/mail/cltbld', 05:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:01 INFO - 'MOZ_NO_REMOTE': '1', 05:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:01 INFO - 'NO_EM_RESTART': '1', 05:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:01 INFO - 'PWD': '/builds/slave/test', 05:46:01 INFO - 'SHELL': '/bin/bash', 05:46:01 INFO - 'SHLVL': '1', 05:46:01 INFO - 'TERM': 'linux', 05:46:01 INFO - 'TMOUT': '86400', 05:46:01 INFO - 'USER': 'cltbld', 05:46:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:01 INFO - '_': '/tools/buildbot/bin/python'} 05:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:01 INFO - Downloading/unpacking jsonschema 05:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:03 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:04 INFO - warning: no files found matching '*.txt' 05:46:04 INFO - no previously-included directories found matching 'build' 05:46:04 INFO - no previously-included directories found matching 'dist' 05:46:04 INFO - no previously-included directories found matching '.git*' 05:46:04 INFO - Installing collected packages: jsonschema, functools32 05:46:04 INFO - Running setup.py install for functools32 05:46:04 INFO - warning: no files found matching '*.txt' 05:46:04 INFO - no previously-included directories found matching 'build' 05:46:04 INFO - no previously-included directories found matching 'dist' 05:46:04 INFO - no previously-included directories found matching '.git*' 05:46:04 INFO - Successfully installed jsonschema functools32 05:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:46: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:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33b2c2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ae7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', '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:46: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', 'flake8'] in /builds/slave/test/build 05:46: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 flake8 05:46:04 INFO - Using env: {'DISPLAY': ':0', 05:46:04 INFO - 'HOME': '/home/cltbld', 05:46:04 INFO - 'LANG': 'en_US.UTF-8', 05:46:04 INFO - 'LANGUAGE': 'en_US:en', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MAIL': '/var/mail/cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SHLVL': '1', 05:46:04 INFO - 'TERM': 'linux', 05:46:04 INFO - 'TMOUT': '86400', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - '_': '/tools/buildbot/bin/python'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 INFO - Downloading/unpacking flake8 05:46: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:46: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:46: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:46: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:46: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:46: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:46:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:06 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:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:07 INFO - no previously-included directories found matching 'docs/_build' 05:46:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:07 INFO - Running setup.py install for pep8 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:07 INFO - no previously-included directories found matching 'docs/_build' 05:46:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:46:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:07 INFO - Cleaning up... 05:46:07 INFO - Return code: 0 05:46:07 INFO - Running post-action listener: _resource_record_post_action 05:46:07 INFO - Running post-action listener: _start_resource_monitoring 05:46:07 INFO - Starting resource monitoring. 05:46:07 INFO - ##### 05:46:07 INFO - ##### Running install step. 05:46:07 INFO - ##### 05:46:07 INFO - Running pre-action listener: _resource_record_pre_action 05:46:07 INFO - Running main action method: install 05:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:07 INFO - Reading from file tmpfile_stdout 05:46:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:07 INFO - Reading from file tmpfile_stdout 05:46:07 INFO - Output received: 05:46:07 INFO - Usage: mozinstall [options] installer 05:46:07 INFO - Options: 05:46:07 INFO - -h, --help show this help message and exit 05:46:07 INFO - -d DEST, --destination=DEST 05:46:07 INFO - Directory to install application into. [default: 05:46:07 INFO - "/builds/slave/test"] 05:46:07 INFO - --app=APP Application being installed. [default: firefox] 05:46:07 INFO - mkdir: /builds/slave/test/build/application 05:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:46:24 INFO - Reading from file tmpfile_stdout 05:46:24 INFO - Output received: 05:46:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:24 INFO - Running post-action listener: _resource_record_post_action 05:46:24 INFO - ##### 05:46:24 INFO - ##### Running run-tests step. 05:46:24 INFO - ##### 05:46:24 INFO - Running pre-action listener: _resource_record_pre_action 05:46:24 INFO - Running main action method: run_tests 05:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:24 INFO - Python 2.7.3 05:46:24 INFO - Return code: 0 05:46:24 INFO - grabbing minidump binary from tooltool 05:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:24 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 0x293d640>, '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 0x293e540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x293e9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:24 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:46:24 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:46:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:24 INFO - Return code: 0 05:46:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:46:26 INFO - Return code: 0 05:46:26 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/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:46:26 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/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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:46:26 INFO - Using env: {'DISPLAY': ':0', 05:46:26 INFO - 'HOME': '/home/cltbld', 05:46:26 INFO - 'LANG': 'en_US.UTF-8', 05:46:26 INFO - 'LANGUAGE': 'en_US:en', 05:46:26 INFO - 'LOGNAME': 'cltbld', 05:46:26 INFO - 'MAIL': '/var/mail/cltbld', 05:46:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:26 INFO - 'MOZ_NO_REMOTE': '1', 05:46:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:26 INFO - 'NO_EM_RESTART': '1', 05:46:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:26 INFO - 'PWD': '/builds/slave/test', 05:46:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:26 INFO - 'SHELL': '/bin/bash', 05:46:26 INFO - 'SHLVL': '1', 05:46:26 INFO - 'TERM': 'linux', 05:46:26 INFO - 'TMOUT': '86400', 05:46:26 INFO - 'USER': 'cltbld', 05:46:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566', 05:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:26 INFO - '_': '/tools/buildbot/bin/python'} 05:46:26 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/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:46:26 INFO - mozversion application_buildid: 20160414030247 05:46:26 INFO - mozversion application_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 05:46:26 INFO - mozversion application_display_name: Nightly 05:46:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:26 INFO - mozversion application_name: Firefox 05:46:26 INFO - mozversion application_remotingname: firefox 05:46:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:26 INFO - mozversion application_vendor: Mozilla 05:46:26 INFO - mozversion application_version: 48.0a1 05:46:26 INFO - mozversion platform_buildid: 20160414030247 05:46:26 INFO - mozversion platform_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 05:46:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:26 INFO - mozversion platform_version: 48.0a1 05:46:26 INFO - using testdate: 1460637986 05:46:26 INFO - actual date: 1460637986 05:46:26 INFO - starting webserver on 'localhost:46537' 05:46:26 INFO - SUITE-START | Running 2 tests 05:46:26 INFO - TEST-START | dromaeo_css 05:46:26 INFO - operating with platform_type : linux_ 05:46:26 INFO - Initialising browser for dromaeo_css test... 05:46:26 INFO - TEST-INFO | started process 8219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjb1nz/profile http://localhost:46537/getInfo.html) 05:46:30 INFO - PROCESS | 8219 | 05:46:30 INFO - PROCESS | 8219 | (process:8288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:46:30 INFO - PROCESS | 8219 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:46:31 INFO - PROCESS | 8219 | __metrics Screen width/height:1600/1200 05:46:31 INFO - PROCESS | 8219 | colorDepth:24 05:46:31 INFO - PROCESS | 8219 | Browser inner width/height: 1024/697 05:46:31 INFO - PROCESS | 8219 | __metrics 05:46:32 ERROR - PROCESS | 8219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:46:33 INFO - TEST-INFO | 8219: exit 0 05:46:33 INFO - Browser initialized. 05:46:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:33 INFO - TEST-INFO | started process 8339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjb1nz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:34 INFO - PROCESS | 8339 | 05:46:34 INFO - PROCESS | 8339 | (process:8397): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:46:44 INFO - PROCESS | 8339 | RSS: Main: 163090432 05:46:44 INFO - PROCESS | 8339 | 05:47:34 INFO - PROCESS | 8339 | 1460638054452 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] 05:49:42 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46537/tests/dromaeo/cssquery-ext.html) 05:49:43 INFO - PROCESS | 8339 | RSS: Main: 169213952 05:49:43 INFO - PROCESS | 8339 | 05:52:45 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-ext.html (next: http://localhost:46537/tests/dromaeo/cssquery-jquery.html) 05:52:45 INFO - PROCESS | 8339 | RSS: Main: 167530496 05:52:45 INFO - PROCESS | 8339 | 05:55:47 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46537/tests/dromaeo/cssquery-mootools.html) 05:55:48 INFO - PROCESS | 8339 | RSS: Main: 166154240 05:55:48 INFO - PROCESS | 8339 | 05:58:50 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46537/tests/dromaeo/cssquery-prototype.html) 05:58:50 INFO - PROCESS | 8339 | RSS: Main: 163594240 05:58:50 INFO - PROCESS | 8339 | 06:01:53 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46537/tests/dromaeo/cssquery-yui.html) 06:01:53 INFO - PROCESS | 8339 | RSS: Main: 164581376 06:01:53 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | Cycle 1(1): loaded http://localhost:46537/tests/dromaeo/cssquery-yui.html (next: http://localhost:46537/tests/dromaeo/cssquery-dojo.html) 06:04:56 INFO - PROCESS | 8339 | RSS: Main: 167186432 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | __start_tp_report 06:04:56 INFO - PROCESS | 8339 | _x_x_mozilla_page_load 06:04:56 INFO - PROCESS | 8339 | _x_x_mozilla_page_load_details 06:04:56 INFO - PROCESS | 8339 | |i|pagename|runs| 06:04:56 INFO - PROCESS | 8339 | |0;dojo.html;3161.1780936956393;3228.2736384313516;3240.9027729168124;3263.967360326396;3288.210829400943;5468.808591699286;5487.835364939048;5491.945080549193;5511.834644960648;5515.283013208283;5376.489233522819;5510.338759348873;5518.006758783417;5543.695096769676;5630.183623374608;4918.409790825097;4962;5048.570871475929;5054.267131265964;5157.922631160517;4974.502549745014;5014.272930425086;5034.395872495305;5082.618803589727;5089.4910508949;4906.53387928148;4974.751262436882;4975.701457912537;5007.198848184273;5034.2196959470975;4996.4503904570465;4998.375203099613;5004.874878128039;5006.674566153189;5016.3980322361185;4881.072596206709;4922.507749225085;4973.303737476756;5010;5046.19260918255;5368.248445217672;5382.381026181961;5386.434424385422;5412.134058550652;5468.179773034037;5843.620164689281;5854.121881717734;5857.85355366115;5875.324337701177;5877.794277200277;5699.145128230799;5869.8239052828485;5917.911231331534;5930.080837470199;5941.584089113764;5498.670079795185;5507.394186639466;5513.145462453326;5536.778528858881;5542.057850165482;5993.61041532299;6005.849853753603;6024.337322894478;6024.457798798129;6054.243219597551;5747.281589801275;5785.334686511021;5815.534757219412;5867.735951882176;5913.201717768132;5771.249737534094;5944.970275148683;5966.045432730829;5970.373110823301;5982.192404025401;5804.361520232771;5810.099434587646;5811.970940145272;5831.475167234885;5887.705614719247;5813.12803079533;5828.970855145697;5854.765809367577;5870.178175055496;5897.734601942923;4390.253656878338;4391.956080439155;4409.757463339483;4426.933595996063;4431.135928493977;3905.7461265017682;3922.5292964844402;3926.2932672118723;3931;3957.881263562098;5564.054110801174;5578.944210557924;5631;5653.575981801381;5676.971615141898;5858.5898987070495;5886.529077673776;5890.204822349014;5904.911426328608;5907.822765317047;5565.1095824667855;5570.805021824298;5615.241942337732;5615.634983726045;5625.915611265835;4910.754462276872;4981.875453113701;4993.151164302078;5051.318072060299;5052.646314757932;6062.605930614496;6072.05883088122;6094.75620975156;6099.756009759649;6121.296050954108;5864.7947321844385;5892.793752218652;5897.203877476486;5901.645901245939;5918.674472904032;6019.187409699634;6026.879462410815;6038.8792224154395;6083;6123.663198524124;5746.051901436216;5766.3368712598585;5797.826065218051;5805.564582656402;5814.098814683731;5857.648541087548;5862.472377486047;5922.082077278029;5929.584929054925;5933.703314834154;5626.43735626434;5737.74180161902;5738.913916291175;5767.163761254678;5812.505936995233;5715.114157305624;5725.2843394575675;5728.341240757366;5734.598578099493;5743.195952566728;5591.384947655836;5627.268455100974;5629.802956896489;5660.98102341566;5666.206731057738;5800.883982320414;5830.387809279964;5848.795292164754;5852.414758524284;5863;5635.436456354331;5657;5676.659400435987;5688.288963879515;5694.316681998187 06:04:56 INFO - PROCESS | 8339 | |1;ext.html;604.6221111805122;639.2424976402963;651.5243871973457;668.0413606474706;677.8678157759239;37352;38179.618203817954;38456.03859903507;38550.22899542015;38673.80663096684;40901.795491022574;41421.17157656845;41482.7925860371;41583.37624935628;41598;8570.442921210117;8673.869891951626;8686.86969695455;8715.215630593246;8726.52004139772;8474.872876906851;8617.267532259766;8625.094365091669;8928.15182557656;8942.463452192856;8869.113088691143;8940.910590894073;8950.194482496607;8967.686130985418;8997.100289970984;8925.241354484877;8934.061923498037;8995.235404990519;9000.054994225642;9016.77458063547;8830.381873268874;8843.734687959372;8867.55662216893;8887.955560222223;8975.41659792118;40991;41471.58528414708;41682.79158604187;41782.164356713;41844.372334415006;3140.7016333448287;3152.858121384543;3170.746340292771;3631.019624701316;3730.7201959852846;28016.439671206666;28029.57955630667;28240.858795706095;28381.290467738265;28423.71576284252;3959.6436320731273;3994.500687414073;4120.443740095079;4134.855280065213;4168.7290326128705;260658;264256;264308;265892;266359.6682016597;36627.816860915525;36926.076848078475;36945;60862.695686521285;61786;37384.626153738114;37730.62269377326;37822;37886;37927.62072379296;13573.321333933263;13691.178529288274;13712.314384280946;13720.794188087186;13746.900247980138;10995.615153469591;10997.230193886351;11063.22557420989;11101.1674124441;11102.777944441066;8648.394612377198;8651.091635378194;8683.826323473495;8715.825683486295;8736.301095912311;3308;3388.4747864081105;3447.7586568940437;3458.7405944554257;3461.0828130545424;945.4374647084974;1081.0162751895737;1092.3664274720643;1148.534843388429;1212.1878341511208;27542.311442214104;27967.44065118727;28054.579181312296;28234;28411.431771364456;1083.0739717541546;1110.955561777536;1144.9713757156137;1155.0413157079604;1158.3918442817587;14809.151968546985;14837.92581037088;15202;15222.391104355702;15323.693526129415;316773;430446;430873;431780;434047;56598.71700641471;57861.71069144627;58128.418715813146;58251;58313.70843145842;1294.2558029133286;1309.1490531154636;1327.290223824413;1330.401319406271;1334.5262431836752;28885.42229155363;29902.252443688212;30242.54636180503;30566.388672226876;30644.387112258075;47155.76422118005;58700;60687.39312606994;60913.999999998225;60975.695121524106;400434;401347;402922;403495;405279;43521.56478435175;43739.34390984201;43991.56008440003;44332.77833610812;44364.77817610891;48152.759236205;48470.75764621155;48705.26942095942;48964.510354895996;49873.750631246614;34267.828660857536;40623.1875362497;40970.59029409787;41657.58342416537;42029;37520.43719344267;38144.237115258096;39196.608033920435;39957.60042399539;40330.59669403268;37271.254574907805;40272.395914060726;42869.57130428656;43977.34033989429;44262.33606495841;32643;34459.13852153716;34787.65212347844;35271.11822204466;35369.82315088511;26852.32869178208;27896.58155127634;28009.719902800713;28145.859270703517;28155.48477005839 06:04:56 INFO - PROCESS | 8339 | |2;jquery.html;379.6639973623343;380.24711072077287;385.1776457263741;387.16179471444326;398.62927477445965;16669.416570420024;18175.54561135972;18931.053447327646;19056.809431905676;19075.427737167905;17312.56718582036;17815.821841781577;18027.4591762247;18039.458816235532;18096.366627168052;5445.809396671118;5539.861503462405;5691.06097493913;5699.458551437628;5717.942820571782;5545.611807173499;5561.416051314614;5579.497845193931;5604.131359639263;5616.9157462638095;5421.295231619883;5552.611317207797;5561.054620714488;5571.777128914839;5579.721013949306;5470.863228419302;5567.832965011056;5581.302337207849;5612.186232996192;5616.185653080322;4877.536843893847;4972.726500042496;4977.527134922213;4980.078685443204;5016.1723315653235;21659.241926532497;22087.226947056937;22198.556028879495;22673.546529069325;22702.545949080926;2202.2622421488823;2248.0895237428867;2527.936801579957;2618;3066.402051599939;13536.390862411215;14144.717105657932;14358.712825743427;14391.640208994755;14568.417263309455;1917.4631103291101;1966.5083729067733;2007.2773801431474;2018.4550171453625;2050.866693664907;73231;73374.89937650939;74548.62725686391;74630.62684686595;74882;9889.50552472388;10024;10309.948450257702;10330.276880618285;10471.84292235617;14253.572392828024;14311.499097531536;14330.355134018993;14338.641533961525;14361;7406;7443.925560744432;7512.812179695551;7542.773716788505;7595.658195381111;7212.459065570103;7233.276672332725;7288;7294.905764135422;7319.560826350436;6264.467520260738;6282.654454005074;6398.776042838478;6449.742010319628;6459.128017717548;1779.7508348831175;1806.4490330449075;1857.9907100464682;1899.6865517189508;1954.218312674913;961.4808003678075;1038.7974345002651;1126.2060247525476;1141.4235810915434;1174.747429302687;16770.496885093467;18081.638367232583;18355.449336519927;18370.265189392543;18703.158357873657;1012.6759436980095;1051.5898799468214;1052.0531521630442;1060.2578195263347;1110.9444527773578;10400.791984160274;10592.89407105919;10669.826319104892;10738.677839664822;10765.30025548337;470940;482090;482565;489842;519486;48233;57401.42598573961;57708;69772.3022769776;71090.2890971094;1064.122099268107;1074.2426589254558;1076.9138468922624;1084.728817795551;1094.6497120921388;16872.493825185265;17005.744913826056;17183.7422438661;17300.394486192923;17347.739783902998;35392.823035884656;35503.64496355003;35622.643773562966;35703.64296357003;36235.45646815353;47567;47605.52394476011;48775.756121219165;48937.75531122321;49304.75347623239;8083.312918401766;8263.876041859497;8265.049519305358;8271.875921861298;8365.74902752894;13009.414576343897;13010.869891301345;13066;13182.868171318547;13300.600981970556;11415.942920285346;11455.713607159887;11748.706282342668;11875.762484750085;11890.405479726152;11139.443027848738;11201.551937922392;11335.206535542433;11410.201285909907;11520.53917843277;11460.02589779878;11734;12104.092193085378;12122.15144939881;12222;8136.105028446747;8162.673493060449;8176.591170441335;8271.54506502148;8424.326053915795;11900.761984760084;11986.700332491757;12011.75976480448;12032.458539365574;12034.338111403607 06:04:56 INFO - PROCESS | 8339 | |3;mootools.html;1508.75859862422;1531.4104069933076;1694.4238958754022;1778.310006736023;1831;7430.628468576577;7898.526088434691;7911.327537159334;8161;8170.101288858228;7931.048274207089;7944.086430060544;7970.561619110947;7992.640331185096;8020.117787043435;2274.647429648407;2286.3255339674793;2291.255342013844;2305.527366889792;2318.6174281243657;2268.1154349803505;2272.8409011369213;2294.093832935989;2302.6085565453827;2305.2162264829954;2249.055396733376;2253.4929640830765;2264.67162261472;2305.6887320211727;2318.2929206591984;2193.111789725164;2204.889755512226;2208.7680793516693;2210.4473881529616;2216.7007453993665;2201.9210586812346;2210.0386331945656;2210.53578748463;2211.9225827096134;2212.6902233687297;8044.879326810044;8059.838803223961;8108.75673729789;8126.959365203195;8150.510969341858;5002.52476014778;5055.772490237948;5115.2071428928575;5126.743662816844;5134.17853143499;3322.1528510229978;3422.281320922609;3504.3341765064556;3531.487934249545;3563.4120370138894;1208.0516794316507;1217.5129948020774;1234.8703386144416;1239.0830785218964;1271.8537368202683;11238.044766194884;11287.322760634306;11294.548218071268;11355.659330220107;11382.60160894373;4450.666200035011;4468.396766436489;4587.541245875453;4628.884277893079;4647.604953578916;9733.951330243304;9745.658901938397;9773.951130244446;9785;9791.118799307955;5073.797048118107;5116.027954688671;5144.948550514522;5155.226715992631;5157.922631160535;4270.444842170498;4635.860924172281;4785.665003449725;4795.304680821261;4814.1815891297865;3884.2231553689376;3905.1408690088133;3929.135590170158;3996.440498330236;4012.1975604878558;1286.530416398008;1293.049608537724;1302.2642207152928;1302.785040468331;1318.5714642740957;688.7830333444949;721.3327671903573;815.9347252219808;817.1297568089965;821.9368688876492;5295.602829787781;5301.151815709468;5508.91736623943;5550.139728342114;5681.233033540502;408.8099033949228;411.8599676110137;414.5605658002527;416.2715248315448;417.2593646277881;3633.4913112164318;3666.2484190740834;3695.833687484016;3701.777893326409;3748.9625103748613;9964.302498825158;10283.588656453658;10363.844542331872;10384.221183411275;10392.844107338396;10114.140298074599;10215.540300686487;10224.846627300596;10251.333663311862;10274.280800343904;7199.3520583147765;7488.887666685004;7521.7743467696055;7607.619619019027;7691.30778229962;5323.680579165262;5358.223057656696;5381.381141168659;5391.892162156813;5482.862928426821;9221.769455763659;9235.07649235071;9341.626334946797;9405.482698451651;9443;9012.143846334588;9611.855822162534;9622.470764107762;9762.316637835283;9796.069373409515;6764.222114456704;7055.541389809646;7242.493025488166;7340.926590734024;7410.9258907412395;7885.329746971572;7908.6045697713735;7954.125046244792;7954.761357159295;7958.164392738679;7107.253738357398;7173.748918787817;7302.233265507258;7403.111626604842;7453.850922981402;6814.897776533455;6858.897116543156;6991.475639327173;7074.964625176841;7081.610511421715;6295.464885484785;6445.581037232565;6463.095166676575;6470.902936456051;6484.513661475314;4942.703437793743;4954.925676114934;4965.652404331662;4978.178600531017;5018.949810501995;4851.58761505276;4893.388326459192;4932.186189278729;4944.604431645388;4994.051130285234 06:04:56 INFO - PROCESS | 8339 | |4;prototype.html;323.7296857124301;325.7475456521196;326.0446890610513;332.34693826630667;332.5576982613126;5959.761609535619;5963.821085367441;6084.8478788030325;6099.420555047274;6121.449069583737;5975.432333928281;5986.580939334249;6014.849628759283;6015.518758499309;6068.211132552762;4329.783510824462;4414.426124603797;4563.863084107482;4578.725276483422;4601.930971035437;4552.4764652065105;4560.293154561048;4588.7246765194195;4594.793234304464;4596.793144308497;4529;4531.773411329436;4573.862784116482;4587.908241835178;4594.885127871813;4255.234057869582;4448.3549885266775;4486.753228572444;4489.977550112261;4492.719574921131;3868.477755502999;3878.1080351519026;3887.7364856421777;3893.4549163117185;3903.355946268862;5720.485156335908;5736.2542869427125;5739.225204597367;5753.137029445575;5768.971155144198;5040.143175660147;5138.7173705446185;5139.10065738498;5171.663841850268;5181.766820493087;6182.412670796267;6202.131701561785;6219.657918814463;6230.844228894269;6262.968685156545;4217.261979153666;4253.872723728215;4275.593818587229;4280.6361459275995;4289.1636130954475;6496.271565942316;6569.967150164219;6581.341865813428;6590.505712071614;6626.469882409396;4325.718828276152;4339.913201735948;4347.3261644445165;4363.2800587903275;4378.387025816388;4346.717463364935;4406.691531592822;4411.360352748833;4430.645548356124;4432;5141.460146684619;5152.098382782998;5156.20078887773;5187.377514698261;5190.24741412493;6294.748210071637;6314.242290925118;6325.652089135142;6341;6341.397567231105;1495.1402943307423;1515.6665533582593;1531.7242896278776;1533.1031346662328;1535.8464153584775;932.7761337279004;981.6809536900536;994.8159590475785;996.5714742660581;1006.7332156978407;6087.239095113111;6103.298120716175;6119.326874043852;6124.663143527059;6181.876362472725;6288.9056664150075;6454.612723236621;6469.353064693587;6491.415772580491;6495.610263384212;5982.850428739229;5987.790427335022;5988.580799344091;5990.760369585168;5996.970015149984;3404.4552871540436;3422.2299982504237;3429.2969941162;3444.190615205425;3459.3081383723356;6441.162648855712;6631.635260060646;6805.6597170141295;6812.48906332027;6883.208431030395;6668.799936001928;6675.4325882300545;6677.232118306457;6683.9228070876725;6702.262751097375;6413.134226879405;6651.501137414713;6769.627670478171;6770.424513916274;6777.796666100025;6440.6135631862235;6483.675816209265;6516.315786842503;6524.965890860773;6561.901571476527;6168.8766224674355;6460.35396460369;6532.510061745293;6541.247756508063;6548;6799.5920244785475;6808.557443766139;6811.829704257235;6820.727170913108;6839.418649414855;4492.9101417970805;4538.841140560065;4547.840825571089;4556.794944227584;4562.22442184836;6386.307628478364;6530.412262896362;6547.250154935034;6555.246146693191;6570.868582628416;6327.778527751507;6336.017917222838;6367.204099487564;6379.362063793584;6385.744570217139;6202.689865506797;6223.159873417031;6225.501959843111;6310.242770867525;6342.556021078481;5923.200367950444;6124.938750612615;6193.163922870355;6247.156633854554;6264.59280146789;6321.936780632135;6347.270063942706;6358.523110766619;6370.522210834299;6420.711068001858;6060.090986352083;6178.9382106180165;6188.2883468399905;6259.998400255937;6261.499080073674 06:04:56 INFO - PROCESS | 8339 | |5;yui.html;798.9241022102898;806.9475484093533;811.6347643560398;812.5124925044973;840.1430540848331;13145.7370852583;13466.528671496488;13525.526606568772;14304.856951430482;14443.061201021927;13222.40499177537;13228.801567976489;13268.203907765517;13312.334383280822;13323.866761332383;660.4452260101526;768.5734417398342;790.5533373643873;791.0191362710256;795.2008231727135;727.8427300592058;727.8980942668031;730.9780706578811;734.2253922112169;738.5421038955828;815.2214635023538;818.1818181818181;819.8401311744212;821.4906757810166;822.383212590557;805.524740403165;810.469142711522;812.2567850416862;813.9918600813975;814.6944895664126;591.3760982163816;591.8816236752667;592.0497601349857;592.380961894821;593.9554533409969;13515.189088654712;13603;13643.38604762778;13685.247311397869;13698.041137120406;13718.588442346745;13861.79207311881;13919.164850108924;14065.578032658934;14132;10938.835917461245;11043.779124417548;11539.538418463251;11546.94226528862;11787.05703543723;3849.711271654637;3866.4973553438153;3901.473301104343;3909.198614284065;3938.2320447512748;58951.41048589502;58986.41013589852;59026.40973590252;59373;59738.701306493625;9847.359921605073;10025.699229023141;10186.898131018743;10321.380717156995;10517.52671129801;16796.58008549796;16812.411565595146;16843.41048063312;16873.91563042177;17005.404810831562;7491.850162996819;7527.623618819037;7528.887066694004;7621.733239336597;7632;4345.500267469219;4441;4441.689081764245;4485.439320084989;4573.977130114328;3236.0777178504486;3304.801711897294;3308.387948229585;3314.6022477302877;3567.9108022299133;624.0452108274347;630.2909227119491;634.8793729191439;637.9521535884827;639.114825966031;655.672163918041;666.5600703535644;703.8768215562257;707.8371974445803;737.1927739125649;9252.722418327327;9253;9453.574589143505;9531.714048578553;9592.424454532751;578.3320265093823;642.8842808294459;726.2084328082416;727.0511981863718;736.1166600079819;4163.063310755056;4235.512916014698;4346.891327716769;4592.081583683277;4631.212693842055;60111;60438.69780651157;60603.48491287665;61603.6919815407;62070;51561.48438515642;51887;52570.47429525656;52584;53172.73413632907;36245.63754362422;36373.45439818405;42361.15277694429;42949;43882;8813.118688131392;8829.911700883165;8877.112288771072;8940.5082720451;9117.179453849185;31008.534871976488;31152.376952461276;31769.04692859218;32237.838810805795;33027;40969.18061638691;44274.33588496111;45843.541564583924;46446.767766160956;47254.291185631555;11237.38194399316;11271.267367621078;11313.434328283718;11323.32060076398;11695.298282103102;12903.41934612926;13228.735425291248;13349.66625834362;13495.59513214605;14101.153930764187;11479.770404591694;11738.823917641072;11752.471138798604;12070.456829442872;12072.698182545506;11785.764284714429;12163.635090947286;12265;12271.877281227431;12300.938495307466;12196.451159697657;12474.937625311815;12541.623751287476;12969.546065888026;13018.828305452176;10002.749931251778;10037.247206459691;10052.64815731446;10185.33795303303;10272.537735801758;10014.649487268201;10063.446510441996;10084.596616135272;10170.694879153638;10242.129418999468 06:04:56 INFO - PROCESS | 8339 | __end_tp_report 06:04:56 INFO - PROCESS | 8339 | __start_cc_report 06:04:56 INFO - PROCESS | 8339 | _x_x_mozilla_cycle_collect,331 06:04:56 INFO - PROCESS | 8339 | __end_cc_report 06:04:56 INFO - PROCESS | 8339 | __startTimestamp1460639096400__endTimestamp 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | ------- Summary: start ------- 06:04:56 INFO - PROCESS | 8339 | Number of tests: 6 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#0] dojo.html Cycles:165 Average:5459.52 Median:5676.66 stddev:625.95 (11.0%) stddev-sans-first:601.34 06:04:56 INFO - PROCESS | 8339 | Values: 3161.2 3228.3 3240.9 3264.0 3288.2 5468.8 5487.8 5491.9 5511.8 5515.3 5376.5 5510.3 5518.0 5543.7 5630.2 4918.4 4962.0 5048.6 5054.3 5157.9 4974.5 5014.3 5034.4 5082.6 5089.5 4906.5 4974.8 4975.7 5007.2 5034.2 4996.5 4998.4 5004.9 5006.7 5016.4 4881.1 4922.5 4973.3 5010.0 5046.2 5368.2 5382.4 5386.4 5412.1 5468.2 5843.6 5854.1 5857.9 5875.3 5877.8 5699.1 5869.8 5917.9 5930.1 5941.6 5498.7 5507.4 5513.1 5536.8 5542.1 5993.6 6005.8 6024.3 6024.5 6054.2 5747.3 5785.3 5815.5 5867.7 5913.2 5771.2 5945.0 5966.0 5970.4 5982.2 5804.4 5810.1 5812.0 5831.5 5887.7 5813.1 5829.0 5854.8 5870.2 5897.7 4390.3 4392.0 4409.8 4426.9 4431.1 3905.7 3922.5 3926.3 3931.0 3957.9 5564.1 5578.9 5631.0 5653.6 5677.0 5858.6 5886.5 5890.2 5904.9 5907.8 5565.1 5570.8 5615.2 5615.6 5625.9 4910.8 4981.9 4993.2 5051.3 5052.6 6062.6 6072.1 6094.8 6099.8 6121.3 5864.8 5892.8 5897.2 5901.6 5918.7 6019.2 6026.9 6038.9 6083.0 6123.7 5746.1 5766.3 5797.8 5805.6 5814.1 5857.6 5862.5 5922.1 5929.6 5933.7 5626.4 5737.7 5738.9 5767.2 5812.5 5715.1 5725.3 5728.3 5734.6 5743.2 5591.4 5627.3 5629.8 5661.0 5666.2 5800.9 5830.4 5848.8 5852.4 5863.0 5635.4 5657.0 5676.7 5688.3 5694.3 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#1] ext.html Cycles:180 Average:51853.67 Median:220195.80 stddev:96660.48 (43.9%) stddev-sans-first:96855.05 06:04:56 INFO - PROCESS | 8339 | Values: 604.6 639.2 651.5 668.0 677.9 37352.0 38179.6 38456.0 38550.2 38673.8 40901.8 41421.2 41482.8 41583.4 41598.0 8570.4 8673.9 8686.9 8715.2 8726.5 8474.9 8617.3 8625.1 8928.2 8942.5 8869.1 8940.9 8950.2 8967.7 8997.1 8925.2 8934.1 8995.2 9000.1 9016.8 8830.4 8843.7 8867.6 8888.0 8975.4 40991.0 41471.6 41682.8 41782.2 41844.4 3140.7 3152.9 3170.7 3631.0 3730.7 28016.4 28029.6 28240.9 28381.3 28423.7 3959.6 3994.5 4120.4 4134.9 4168.7 260658.0 264256.0 264308.0 265892.0 266359.7 36627.8 36926.1 36945.0 60862.7 61786.0 37384.6 37730.6 37822.0 37886.0 37927.6 13573.3 13691.2 13712.3 13720.8 13746.9 10995.6 10997.2 11063.2 11101.2 11102.8 8648.4 8651.1 8683.8 8715.8 8736.3 3308.0 3388.5 3447.8 3458.7 3461.1 945.4 1081.0 1092.4 1148.5 1212.2 27542.3 27967.4 28054.6 28234.0 28411.4 1083.1 1111.0 1145.0 1155.0 1158.4 14809.2 14837.9 15202.0 15222.4 15323.7 316773.0 430446.0 430873.0 431780.0 434047.0 56598.7 57861.7 58128.4 58251.0 58313.7 1294.3 1309.1 1327.3 1330.4 1334.5 28885.4 29902.3 30242.5 30566.4 30644.4 47155.8 58700.0 60687.4 60914.0 60975.7 400434.0 401347.0 402922.0 403495.0 405279.0 43521.6 43739.3 43991.6 44332.8 44364.8 48152.8 48470.8 48705.3 48964.5 49873.8 34267.8 40623.2 40970.6 41657.6 42029.0 37520.4 38144.2 39196.6 39957.6 40330.6 37271.3 40272.4 42869.6 43977.3 44262.3 32643.0 34459.1 34787.7 35271.1 35369.8 26852.3 27896.6 28009.7 28145.9 28155.5 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#2] jquery.html Cycles:180 Average:27390.99 Median:22142.89 stddev:79949.39 (361.1%) stddev-sans-first:80147.94 06:04:56 INFO - PROCESS | 8339 | Values: 379.7 380.2 385.2 387.2 398.6 16669.4 18175.5 18931.1 19056.8 19075.4 17312.6 17815.8 18027.5 18039.5 18096.4 5445.8 5539.9 5691.1 5699.5 5717.9 5545.6 5561.4 5579.5 5604.1 5616.9 5421.3 5552.6 5561.1 5571.8 5579.7 5470.9 5567.8 5581.3 5612.2 5616.2 4877.5 4972.7 4977.5 4980.1 5016.2 21659.2 22087.2 22198.6 22673.5 22702.5 2202.3 2248.1 2527.9 2618.0 3066.4 13536.4 14144.7 14358.7 14391.6 14568.4 1917.5 1966.5 2007.3 2018.5 2050.9 73231.0 73374.9 74548.6 74630.6 74882.0 9889.5 10024.0 10309.9 10330.3 10471.8 14253.6 14311.5 14330.4 14338.6 14361.0 7406.0 7443.9 7512.8 7542.8 7595.7 7212.5 7233.3 7288.0 7294.9 7319.6 6264.5 6282.7 6398.8 6449.7 6459.1 1779.8 1806.4 1858.0 1899.7 1954.2 961.5 1038.8 1126.2 1141.4 1174.7 16770.5 18081.6 18355.4 18370.3 18703.2 1012.7 1051.6 1052.1 1060.3 1110.9 10400.8 10592.9 10669.8 10738.7 10765.3 470940.0 482090.0 482565.0 489842.0 519486.0 48233.0 57401.4 57708.0 69772.3 71090.3 1064.1 1074.2 1076.9 1084.7 1094.6 16872.5 17005.7 17183.7 17300.4 17347.7 35392.8 35503.6 35622.6 35703.6 36235.5 47567.0 47605.5 48775.8 48937.8 49304.8 8083.3 8263.9 8265.0 8271.9 8365.7 13009.4 13010.9 13066.0 13182.9 13300.6 11415.9 11455.7 11748.7 11875.8 11890.4 11139.4 11201.6 11335.2 11410.2 11520.5 11460.0 11734.0 12104.1 12122.2 12222.0 8136.1 8162.7 8176.6 8271.5 8424.3 11900.8 11986.7 12011.8 12032.5 12034.3 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#3] mootools.html Cycles:180 Average:5435.64 Median:4971.92 stddev:3035.04 (61.0%) stddev-sans-first:3029.21 06:04:56 INFO - PROCESS | 8339 | Values: 1508.8 1531.4 1694.4 1778.3 1831.0 7430.6 7898.5 7911.3 8161.0 8170.1 7931.0 7944.1 7970.6 7992.6 8020.1 2274.6 2286.3 2291.3 2305.5 2318.6 2268.1 2272.8 2294.1 2302.6 2305.2 2249.1 2253.5 2264.7 2305.7 2318.3 2193.1 2204.9 2208.8 2210.4 2216.7 2201.9 2210.0 2210.5 2211.9 2212.7 8044.9 8059.8 8108.8 8127.0 8150.5 5002.5 5055.8 5115.2 5126.7 5134.2 3322.2 3422.3 3504.3 3531.5 3563.4 1208.1 1217.5 1234.9 1239.1 1271.9 11238.0 11287.3 11294.5 11355.7 11382.6 4450.7 4468.4 4587.5 4628.9 4647.6 9734.0 9745.7 9774.0 9785.0 9791.1 5073.8 5116.0 5144.9 5155.2 5157.9 4270.4 4635.9 4785.7 4795.3 4814.2 3884.2 3905.1 3929.1 3996.4 4012.2 1286.5 1293.0 1302.3 1302.8 1318.6 688.8 721.3 815.9 817.1 821.9 5295.6 5301.2 5508.9 5550.1 5681.2 408.8 411.9 414.6 416.3 417.3 3633.5 3666.2 3695.8 3701.8 3749.0 9964.3 10283.6 10363.8 10384.2 10392.8 10114.1 10215.5 10224.8 10251.3 10274.3 7199.4 7488.9 7521.8 7607.6 7691.3 5323.7 5358.2 5381.4 5391.9 5482.9 9221.8 9235.1 9341.6 9405.5 9443.0 9012.1 9611.9 9622.5 9762.3 9796.1 6764.2 7055.5 7242.5 7340.9 7410.9 7885.3 7908.6 7954.1 7954.8 7958.2 7107.3 7173.7 7302.2 7403.1 7453.9 6814.9 6858.9 6991.5 7075.0 7081.6 6295.5 6445.6 6463.1 6470.9 6484.5 4942.7 4954.9 4965.7 4978.2 5018.9 4851.6 4893.4 4932.2 4944.6 4994.1 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#4] prototype.html Cycles:180 Average:5256.71 Median:6086.04 stddev:1614.62 (26.5%) stddev-sans-first:1576.12 06:04:56 INFO - PROCESS | 8339 | Values: 323.7 325.7 326.0 332.3 332.6 5959.8 5963.8 6084.8 6099.4 6121.4 5975.4 5986.6 6014.8 6015.5 6068.2 4329.8 4414.4 4563.9 4578.7 4601.9 4552.5 4560.3 4588.7 4594.8 4596.8 4529.0 4531.8 4573.9 4587.9 4594.9 4255.2 4448.4 4486.8 4490.0 4492.7 3868.5 3878.1 3887.7 3893.5 3903.4 5720.5 5736.3 5739.2 5753.1 5769.0 5040.1 5138.7 5139.1 5171.7 5181.8 6182.4 6202.1 6219.7 6230.8 6263.0 4217.3 4253.9 4275.6 4280.6 4289.2 6496.3 6570.0 6581.3 6590.5 6626.5 4325.7 4339.9 4347.3 4363.3 4378.4 4346.7 4406.7 4411.4 4430.6 4432.0 5141.5 5152.1 5156.2 5187.4 5190.2 6294.7 6314.2 6325.7 6341.0 6341.4 1495.1 1515.7 1531.7 1533.1 1535.8 932.8 981.7 994.8 996.6 1006.7 6087.2 6103.3 6119.3 6124.7 6181.9 6288.9 6454.6 6469.4 6491.4 6495.6 5982.9 5987.8 5988.6 5990.8 5997.0 3404.5 3422.2 3429.3 3444.2 3459.3 6441.2 6631.6 6805.7 6812.5 6883.2 6668.8 6675.4 6677.2 6683.9 6702.3 6413.1 6651.5 6769.6 6770.4 6777.8 6440.6 6483.7 6516.3 6525.0 6561.9 6168.9 6460.4 6532.5 6541.2 6548.0 6799.6 6808.6 6811.8 6820.7 6839.4 4492.9 4538.8 4547.8 4556.8 4562.2 6386.3 6530.4 6547.3 6555.2 6570.9 6327.8 6336.0 6367.2 6379.4 6385.7 6202.7 6223.2 6225.5 6310.2 6342.6 5923.2 6124.9 6193.2 6247.2 6264.6 6321.9 6347.3 6358.5 6370.5 6420.7 6060.1 6178.9 6188.3 6260.0 6261.5 06:04:56 INFO - PROCESS | 8339 | 06:04:56 INFO - PROCESS | 8339 | [#5] yui.html Cycles:180 Average:14246.70 Median:23647.25 stddev:16595.87 (70.2%) stddev-sans-first:16611.70 06:04:56 INFO - PROCESS | 8339 | Values: 798.9 806.9 811.6 812.5 840.1 13145.7 13466.5 13525.5 14304.9 14443.1 13222.4 13228.8 13268.2 13312.3 13323.9 660.4 768.6 790.6 791.0 795.2 727.8 727.9 731.0 734.2 738.5 815.2 818.2 819.8 821.5 822.4 805.5 810.5 812.3 814.0 814.7 591.4 591.9 592.0 592.4 594.0 13515.2 13603.0 13643.4 13685.2 13698.0 13718.6 13861.8 13919.2 14065.6 14132.0 10938.8 11043.8 11539.5 11546.9 11787.1 3849.7 3866.5 3901.5 3909.2 3938.2 58951.4 58986.4 59026.4 59373.0 59738.7 9847.4 10025.7 10186.9 10321.4 10517.5 16796.6 16812.4 16843.4 16873.9 17005.4 7491.9 7527.6 7528.9 7621.7 7632.0 4345.5 4441.0 4441.7 4485.4 4574.0 3236.1 3304.8 3308.4 3314.6 3567.9 624.0 630.3 634.9 638.0 639.1 655.7 666.6 703.9 707.8 737.2 9252.7 9253.0 9453.6 9531.7 9592.4 578.3 642.9 726.2 727.1 736.1 4163.1 4235.5 4346.9 4592.1 4631.2 60111.0 60438.7 60603.5 61603.7 62070.0 51561.5 51887.0 52570.5 52584.0 53172.7 36245.6 36373.5 42361.2 42949.0 43882.0 8813.1 8829.9 8877.1 8940.5 9117.2 31008.5 31152.4 31769.0 32237.8 33027.0 40969.2 44274.3 45843.5 46446.8 47254.3 11237.4 11271.3 11313.4 11323.3 11695.3 12903.4 13228.7 13349.7 13495.6 14101.2 11479.8 11738.8 11752.5 12070.5 12072.7 11785.8 12163.6 12265.0 12271.9 12300.9 12196.5 12474.9 12541.6 12969.5 13018.8 10002.7 10037.2 10052.6 10185.3 10272.5 10014.6 10063.4 10084.6 10170.7 10242.1 06:04:56 INFO - PROCESS | 8339 | -------- Summary: end -------- 06:04:56 INFO - PROCESS | 8339 | 06:04:57 INFO - TEST-INFO | 8339: exit 0 06:04:57 INFO - TEST-OK | dromaeo_css | took 1110916ms 06:04:57 INFO - TEST-START | kraken 06:04:57 INFO - operating with platform_type : linux_ 06:04:57 INFO - Initialising browser for kraken test... 06:04:57 INFO - TEST-INFO | started process 8575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiq_nxu/profile http://localhost:46537/getInfo.html) 06:05:01 INFO - PROCESS | 8575 | 06:05:01 INFO - PROCESS | 8575 | (process:8640): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:01 INFO - PROCESS | 8575 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 06:05:02 INFO - PROCESS | 8575 | __metrics Screen width/height:1600/1200 06:05:02 INFO - PROCESS | 8575 | colorDepth:24 06:05:02 INFO - PROCESS | 8575 | Browser inner width/height: 1024/697 06:05:02 INFO - PROCESS | 8575 | __metrics 06:05:02 ERROR - PROCESS | 8575 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:05:03 INFO - TEST-INFO | 8575: exit 0 06:05:03 INFO - Browser initialized. 06:05:03 INFO - Running cycle 1/1 for kraken test... 06:05:03 INFO - TEST-INFO | started process 8691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiq_nxu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:05 INFO - PROCESS | 8691 | 06:05:05 INFO - PROCESS | 8691 | (process:8751): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:05:15 INFO - PROCESS | 8691 | RSS: Main: 163233792 06:05:15 INFO - PROCESS | 8691 | 06:05:18 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46537/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:18 INFO - PROCESS | 8691 | RSS: Main: 167501824 06:05:18 INFO - PROCESS | 8691 | 06:05:21 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46537/tests/kraken/driver.html?testName=audio-dft) 06:05:22 INFO - PROCESS | 8691 | RSS: Main: 171057152 06:05:22 INFO - PROCESS | 8691 | 06:05:25 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46537/tests/kraken/driver.html?testName=audio-fft) 06:05:25 INFO - PROCESS | 8691 | RSS: Main: 163495936 06:05:25 INFO - PROCESS | 8691 | 06:05:28 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46537/tests/kraken/driver.html?testName=audio-oscillator) 06:05:28 INFO - PROCESS | 8691 | RSS: Main: 164245504 06:05:28 INFO - PROCESS | 8691 | 06:05:30 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:31 INFO - PROCESS | 8691 | RSS: Main: 163999744 06:05:31 INFO - PROCESS | 8691 | 06:05:34 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46537/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:35 INFO - PROCESS | 8691 | RSS: Main: 164225024 06:05:35 INFO - PROCESS | 8691 | 06:05:38 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46537/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:39 INFO - PROCESS | 8691 | RSS: Main: 164323328 06:05:39 INFO - PROCESS | 8691 | 06:05:42 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46537/tests/kraken/driver.html?testName=json-parse-financial) 06:05:42 INFO - PROCESS | 8691 | RSS: Main: 164974592 06:05:42 INFO - PROCESS | 8691 | 06:05:44 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:44 INFO - PROCESS | 8691 | RSS: Main: 164581376 06:05:44 INFO - PROCESS | 8691 | 06:05:46 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:47 INFO - PROCESS | 8691 | RSS: Main: 164261888 06:05:47 INFO - PROCESS | 8691 | 06:05:49 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:50 INFO - PROCESS | 8691 | RSS: Main: 164810752 06:05:50 INFO - PROCESS | 8691 | 06:05:52 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:53 INFO - PROCESS | 8691 | RSS: Main: 165974016 06:05:53 INFO - PROCESS | 8691 | 06:05:56 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:56 INFO - PROCESS | 8691 | RSS: Main: 165134336 06:05:56 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | Cycle 1(1): loaded http://localhost:46537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46537/tests/kraken/driver.html?testName=ai-astar) 06:05:58 INFO - PROCESS | 8691 | RSS: Main: 167067648 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | __start_tp_report 06:05:58 INFO - PROCESS | 8691 | _x_x_mozilla_page_load 06:05:58 INFO - PROCESS | 8691 | _x_x_mozilla_page_load_details 06:05:58 INFO - PROCESS | 8691 | |i|pagename|runs| 06:05:58 INFO - PROCESS | 8691 | |0;ai-astar;111;105;111;109;114;121;109;112;111;111 06:05:58 INFO - PROCESS | 8691 | |1;audio-beat-detection;164;127;154;183;137;174;160;131;192;133 06:05:58 INFO - PROCESS | 8691 | |2;audio-dft;163;163;163;163;161;165;171;162;166;163 06:05:58 INFO - PROCESS | 8691 | |3;audio-fft;76;74;77;156;73;73;76;77;161;77 06:05:58 INFO - PROCESS | 8691 | |4;audio-oscillator;93;92;146;93;94;92;141;93;91;140 06:05:58 INFO - PROCESS | 8691 | |5;imaging-gaussian-blur;119;118;119;118;118;117;117;117;118;117 06:05:58 INFO - PROCESS | 8691 | |6;imaging-darkroom;148;147;147;147;148;146;146;148;148;148 06:05:58 INFO - PROCESS | 8691 | |7;imaging-desaturate;97;97;95;100;96;95;96;96;96;95 06:05:58 INFO - PROCESS | 8691 | |8;json-parse-financial;58;58;61;58;59;59;58;76;56;62 06:05:58 INFO - PROCESS | 8691 | |9;json-stringify-tinderbox;60;62;62;61;62;63;62;63;62;63 06:05:58 INFO - PROCESS | 8691 | |10;stanford-crypto-aes;80;82;82;83;92;84;82;82;82;94 06:05:58 INFO - PROCESS | 8691 | |11;stanford-crypto-ccm;140;143;138;137;136;137;129;132;164;136 06:05:58 INFO - PROCESS | 8691 | |12;stanford-crypto-pbkdf2;173;174;169;171;172;166;172;170;172;175 06:05:58 INFO - PROCESS | 8691 | |13;stanford-crypto-sha256-iterative;71;70;79;68;69;70;71;69;70;74 06:05:58 INFO - PROCESS | 8691 | __end_tp_report 06:05:58 INFO - PROCESS | 8691 | __start_cc_report 06:05:58 INFO - PROCESS | 8691 | _x_x_mozilla_cycle_collect,850 06:05:58 INFO - PROCESS | 8691 | __end_cc_report 06:05:58 INFO - PROCESS | 8691 | __startTimestamp1460639158767__endTimestamp 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | ------- Summary: start ------- 06:05:58 INFO - PROCESS | 8691 | Number of tests: 14 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 06:05:58 INFO - PROCESS | 8691 | Values: 111.0 105.0 111.0 109.0 114.0 121.0 109.0 112.0 111.0 111.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:162.00 stddev:23.06 (14.2%) stddev-sans-first:24.25 06:05:58 INFO - PROCESS | 8691 | Values: 164.0 127.0 154.0 183.0 137.0 174.0 160.0 131.0 192.0 133.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:2.83 (1.7%) stddev-sans-first:2.98 06:05:58 INFO - PROCESS | 8691 | Values: 163.0 163.0 163.0 163.0 161.0 165.0 171.0 162.0 166.0 163.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:35.10 (46.2%) stddev-sans-first:36.75 06:05:58 INFO - PROCESS | 8691 | Values: 76.0 74.0 77.0 156.0 73.0 73.0 76.0 77.0 161.0 77.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.50 stddev:24.10 (26.1%) stddev-sans-first:24.98 06:05:58 INFO - PROCESS | 8691 | Values: 93.0 92.0 146.0 93.0 94.0 92.0 141.0 93.0 91.0 140.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 06:05:58 INFO - PROCESS | 8691 | Values: 119.0 118.0 119.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 06:05:58 INFO - PROCESS | 8691 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 146.0 148.0 148.0 148.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.56 06:05:58 INFO - PROCESS | 8691 | Values: 97.0 97.0 95.0 100.0 96.0 95.0 96.0 96.0 96.0 95.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:5.70 (9.7%) stddev-sans-first:5.97 06:05:58 INFO - PROCESS | 8691 | Values: 58.0 58.0 61.0 58.0 59.0 59.0 58.0 76.0 56.0 62.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 06:05:58 INFO - PROCESS | 8691 | Values: 60.0 62.0 62.0 61.0 62.0 63.0 62.0 63.0 62.0 63.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:82.50 stddev:4.72 (5.7%) stddev-sans-first:4.74 06:05:58 INFO - PROCESS | 8691 | Values: 80.0 82.0 82.0 83.0 92.0 84.0 82.0 82.0 82.0 94.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:137.50 stddev:9.53 (6.9%) stddev-sans-first:10.11 06:05:58 INFO - PROCESS | 8691 | Values: 140.0 143.0 138.0 137.0 136.0 137.0 129.0 132.0 164.0 136.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.59 (1.5%) stddev-sans-first:2.68 06:05:58 INFO - PROCESS | 8691 | Values: 173.0 174.0 169.0 171.0 172.0 166.0 172.0 170.0 172.0 175.0 06:05:58 INFO - PROCESS | 8691 | 06:05:58 INFO - PROCESS | 8691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:3.21 (4.6%) stddev-sans-first:3.41 06:05:58 INFO - PROCESS | 8691 | Values: 71.0 70.0 79.0 68.0 69.0 70.0 71.0 69.0 70.0 74.0 06:05:58 INFO - PROCESS | 8691 | -------- Summary: end -------- 06:05:58 INFO - PROCESS | 8691 | 06:05:59 INFO - TEST-INFO | 8691: exit 0 06:05:59 INFO - TEST-OK | kraken | took 62623ms 06:05:59 INFO - SUITE-END | took 1173s 06:05:59 INFO - Completed test suite (00:19:33) 06:05:59 INFO - javascript benchmark 06:05:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.1780936956393, 3228.2736384313516, 3240.9027729168124, 3263.967360326396, 3288.210829400943, 5468.808591699286, 5487.835364939048, 5491.945080549193, 5511.834644960648, 5515.283013208283, 5376.489233522819, 5510.338759348873, 5518.006758783417, 5543.695096769676, 5630.183623374608, 4918.409790825097, 4962.0, 5048.570871475929, 5054.267131265964, 5157.922631160517, 4974.502549745014, 5014.272930425086, 5034.395872495305, 5082.618803589727, 5089.4910508949, 4906.53387928148, 4974.751262436882, 4975.701457912537, 5007.198848184273, 5034.2196959470975, 4996.4503904570465, 4998.375203099613, 5004.874878128039, 5006.674566153189, 5016.3980322361185, 4881.072596206709, 4922.507749225085, 4973.303737476756, 5010.0, 5046.19260918255, 5368.248445217672, 5382.381026181961, 5386.434424385422, 5412.134058550652, 5468.179773034037, 5843.620164689281, 5854.121881717734, 5857.85355366115, 5875.324337701177, 5877.794277200277, 5699.145128230799, 5869.8239052828485, 5917.911231331534, 5930.080837470199, 5941.584089113764, 5498.670079795185, 5507.394186639466, 5513.145462453326, 5536.778528858881, 5542.057850165482, 5993.61041532299, 6005.849853753603, 6024.337322894478, 6024.457798798129, 6054.243219597551, 5747.281589801275, 5785.334686511021, 5815.534757219412, 5867.735951882176, 5913.201717768132, 5771.249737534094, 5944.970275148683, 5966.045432730829, 5970.373110823301, 5982.192404025401, 5804.361520232771, 5810.099434587646, 5811.970940145272, 5831.475167234885, 5887.705614719247, 5813.12803079533, 5828.970855145697, 5854.765809367577, 5870.178175055496, 5897.734601942923, 4390.253656878338, 4391.956080439155, 4409.757463339483, 4426.933595996063, 4431.135928493977, 3905.7461265017682, 3922.5292964844402, 3926.2932672118723, 3931.0, 3957.881263562098, 5564.054110801174, 5578.944210557924, 5631.0, 5653.575981801381, 5676.971615141898, 5858.5898987070495, 5886.529077673776, 5890.204822349014, 5904.911426328608, 5907.822765317047, 5565.1095824667855, 5570.805021824298, 5615.241942337732, 5615.634983726045, 5625.915611265835, 4910.754462276872, 4981.875453113701, 4993.151164302078, 5051.318072060299, 5052.646314757932, 6062.605930614496, 6072.05883088122, 6094.75620975156, 6099.756009759649, 6121.296050954108, 5864.7947321844385, 5892.793752218652, 5897.203877476486, 5901.645901245939, 5918.674472904032, 6019.187409699634, 6026.879462410815, 6038.8792224154395, 6083.0, 6123.663198524124, 5746.051901436216, 5766.3368712598585, 5797.826065218051, 5805.564582656402, 5814.098814683731, 5857.648541087548, 5862.472377486047, 5922.082077278029, 5929.584929054925, 5933.703314834154, 5626.43735626434, 5737.74180161902, 5738.913916291175, 5767.163761254678, 5812.505936995233, 5715.114157305624, 5725.2843394575675, 5728.341240757366, 5734.598578099493, 5743.195952566728, 5591.384947655836, 5627.268455100974, 5629.802956896489, 5660.98102341566, 5666.206731057738, 5800.883982320414, 5830.387809279964, 5848.795292164754, 5852.414758524284, 5863.0, 5635.436456354331, 5657.0, 5676.659400435987, 5688.288963879515, 5694.316681998187], "value": 5417.014529424204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6221111805122, 639.2424976402963, 651.5243871973457, 668.0413606474706, 677.8678157759239, 37352.0, 38179.618203817954, 38456.03859903507, 38550.22899542015, 38673.80663096684, 40901.795491022574, 41421.17157656845, 41482.7925860371, 41583.37624935628, 41598.0, 8570.442921210117, 8673.869891951626, 8686.86969695455, 8715.215630593246, 8726.52004139772, 8474.872876906851, 8617.267532259766, 8625.094365091669, 8928.15182557656, 8942.463452192856, 8869.113088691143, 8940.910590894073, 8950.194482496607, 8967.686130985418, 8997.100289970984, 8925.241354484877, 8934.061923498037, 8995.235404990519, 9000.054994225642, 9016.77458063547, 8830.381873268874, 8843.734687959372, 8867.55662216893, 8887.955560222223, 8975.41659792118, 40991.0, 41471.58528414708, 41682.79158604187, 41782.164356713, 41844.372334415006, 3140.7016333448287, 3152.858121384543, 3170.746340292771, 3631.019624701316, 3730.7201959852846, 28016.439671206666, 28029.57955630667, 28240.858795706095, 28381.290467738265, 28423.71576284252, 3959.6436320731273, 3994.500687414073, 4120.443740095079, 4134.855280065213, 4168.7290326128705, 260658.0, 264256.0, 264308.0, 265892.0, 266359.6682016597, 36627.816860915525, 36926.076848078475, 36945.0, 60862.695686521285, 61786.0, 37384.626153738114, 37730.62269377326, 37822.0, 37886.0, 37927.62072379296, 13573.321333933263, 13691.178529288274, 13712.314384280946, 13720.794188087186, 13746.900247980138, 10995.615153469591, 10997.230193886351, 11063.22557420989, 11101.1674124441, 11102.777944441066, 8648.394612377198, 8651.091635378194, 8683.826323473495, 8715.825683486295, 8736.301095912311, 3308.0, 3388.4747864081105, 3447.7586568940437, 3458.7405944554257, 3461.0828130545424, 945.4374647084974, 1081.0162751895737, 1092.3664274720643, 1148.534843388429, 1212.1878341511208, 27542.311442214104, 27967.44065118727, 28054.579181312296, 28234.0, 28411.431771364456, 1083.0739717541546, 1110.955561777536, 1144.9713757156137, 1155.0413157079604, 1158.3918442817587, 14809.151968546985, 14837.92581037088, 15202.0, 15222.391104355702, 15323.693526129415, 316773.0, 430446.0, 430873.0, 431780.0, 434047.0, 56598.71700641471, 57861.71069144627, 58128.418715813146, 58251.0, 58313.70843145842, 1294.2558029133286, 1309.1490531154636, 1327.290223824413, 1330.401319406271, 1334.5262431836752, 28885.42229155363, 29902.252443688212, 30242.54636180503, 30566.388672226876, 30644.387112258075, 47155.76422118005, 58700.0, 60687.39312606994, 60913.999999998225, 60975.695121524106, 400434.0, 401347.0, 402922.0, 403495.0, 405279.0, 43521.56478435175, 43739.34390984201, 43991.56008440003, 44332.77833610812, 44364.77817610891, 48152.759236205, 48470.75764621155, 48705.26942095942, 48964.510354895996, 49873.750631246614, 34267.828660857536, 40623.1875362497, 40970.59029409787, 41657.58342416537, 42029.0, 37520.43719344267, 38144.237115258096, 39196.608033920435, 39957.60042399539, 40330.59669403268, 37271.254574907805, 40272.395914060726, 42869.57130428656, 43977.34033989429, 44262.33606495841, 32643.0, 34459.13852153716, 34787.65212347844, 35271.11822204466, 35369.82315088511, 26852.32869178208, 27896.58155127634, 28009.719902800713, 28145.859270703517, 28155.48477005839], "value": 18307.694722846507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.6639973623343, 380.24711072077287, 385.1776457263741, 387.16179471444326, 398.62927477445965, 16669.416570420024, 18175.54561135972, 18931.053447327646, 19056.809431905676, 19075.427737167905, 17312.56718582036, 17815.821841781577, 18027.4591762247, 18039.458816235532, 18096.366627168052, 5445.809396671118, 5539.861503462405, 5691.06097493913, 5699.458551437628, 5717.942820571782, 5545.611807173499, 5561.416051314614, 5579.497845193931, 5604.131359639263, 5616.9157462638095, 5421.295231619883, 5552.611317207797, 5561.054620714488, 5571.777128914839, 5579.721013949306, 5470.863228419302, 5567.832965011056, 5581.302337207849, 5612.186232996192, 5616.185653080322, 4877.536843893847, 4972.726500042496, 4977.527134922213, 4980.078685443204, 5016.1723315653235, 21659.241926532497, 22087.226947056937, 22198.556028879495, 22673.546529069325, 22702.545949080926, 2202.2622421488823, 2248.0895237428867, 2527.936801579957, 2618.0, 3066.402051599939, 13536.390862411215, 14144.717105657932, 14358.712825743427, 14391.640208994755, 14568.417263309455, 1917.4631103291101, 1966.5083729067733, 2007.2773801431474, 2018.4550171453625, 2050.866693664907, 73231.0, 73374.89937650939, 74548.62725686391, 74630.62684686595, 74882.0, 9889.50552472388, 10024.0, 10309.948450257702, 10330.276880618285, 10471.84292235617, 14253.572392828024, 14311.499097531536, 14330.355134018993, 14338.641533961525, 14361.0, 7406.0, 7443.925560744432, 7512.812179695551, 7542.773716788505, 7595.658195381111, 7212.459065570103, 7233.276672332725, 7288.0, 7294.905764135422, 7319.560826350436, 6264.467520260738, 6282.654454005074, 6398.776042838478, 6449.742010319628, 6459.128017717548, 1779.7508348831175, 1806.4490330449075, 1857.9907100464682, 1899.6865517189508, 1954.218312674913, 961.4808003678075, 1038.7974345002651, 1126.2060247525476, 1141.4235810915434, 1174.747429302687, 16770.496885093467, 18081.638367232583, 18355.449336519927, 18370.265189392543, 18703.158357873657, 1012.6759436980095, 1051.5898799468214, 1052.0531521630442, 1060.2578195263347, 1110.9444527773578, 10400.791984160274, 10592.89407105919, 10669.826319104892, 10738.677839664822, 10765.30025548337, 470940.0, 482090.0, 482565.0, 489842.0, 519486.0, 48233.0, 57401.42598573961, 57708.0, 69772.3022769776, 71090.2890971094, 1064.122099268107, 1074.2426589254558, 1076.9138468922624, 1084.728817795551, 1094.6497120921388, 16872.493825185265, 17005.744913826056, 17183.7422438661, 17300.394486192923, 17347.739783902998, 35392.823035884656, 35503.64496355003, 35622.643773562966, 35703.64296357003, 36235.45646815353, 47567.0, 47605.52394476011, 48775.756121219165, 48937.75531122321, 49304.75347623239, 8083.312918401766, 8263.876041859497, 8265.049519305358, 8271.875921861298, 8365.74902752894, 13009.414576343897, 13010.869891301345, 13066.0, 13182.868171318547, 13300.600981970556, 11415.942920285346, 11455.713607159887, 11748.706282342668, 11875.762484750085, 11890.405479726152, 11139.443027848738, 11201.551937922392, 11335.206535542433, 11410.201285909907, 11520.53917843277, 11460.02589779878, 11734.0, 12104.092193085378, 12122.15144939881, 12222.0, 8136.105028446747, 8162.673493060449, 8176.591170441335, 8271.54506502148, 8424.326053915795, 11900.761984760084, 11986.700332491757, 12011.75976480448, 12032.458539365574, 12034.338111403607], "value": 9017.934721798418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.75859862422, 1531.4104069933076, 1694.4238958754022, 1778.310006736023, 1831.0, 7430.628468576577, 7898.526088434691, 7911.327537159334, 8161.0, 8170.101288858228, 7931.048274207089, 7944.086430060544, 7970.561619110947, 7992.640331185096, 8020.117787043435, 2274.647429648407, 2286.3255339674793, 2291.255342013844, 2305.527366889792, 2318.6174281243657, 2268.1154349803505, 2272.8409011369213, 2294.093832935989, 2302.6085565453827, 2305.2162264829954, 2249.055396733376, 2253.4929640830765, 2264.67162261472, 2305.6887320211727, 2318.2929206591984, 2193.111789725164, 2204.889755512226, 2208.7680793516693, 2210.4473881529616, 2216.7007453993665, 2201.9210586812346, 2210.0386331945656, 2210.53578748463, 2211.9225827096134, 2212.6902233687297, 8044.879326810044, 8059.838803223961, 8108.75673729789, 8126.959365203195, 8150.510969341858, 5002.52476014778, 5055.772490237948, 5115.2071428928575, 5126.743662816844, 5134.17853143499, 3322.1528510229978, 3422.281320922609, 3504.3341765064556, 3531.487934249545, 3563.4120370138894, 1208.0516794316507, 1217.5129948020774, 1234.8703386144416, 1239.0830785218964, 1271.8537368202683, 11238.044766194884, 11287.322760634306, 11294.548218071268, 11355.659330220107, 11382.60160894373, 4450.666200035011, 4468.396766436489, 4587.541245875453, 4628.884277893079, 4647.604953578916, 9733.951330243304, 9745.658901938397, 9773.951130244446, 9785.0, 9791.118799307955, 5073.797048118107, 5116.027954688671, 5144.948550514522, 5155.226715992631, 5157.922631160535, 4270.444842170498, 4635.860924172281, 4785.665003449725, 4795.304680821261, 4814.1815891297865, 3884.2231553689376, 3905.1408690088133, 3929.135590170158, 3996.440498330236, 4012.1975604878558, 1286.530416398008, 1293.049608537724, 1302.2642207152928, 1302.785040468331, 1318.5714642740957, 688.7830333444949, 721.3327671903573, 815.9347252219808, 817.1297568089965, 821.9368688876492, 5295.602829787781, 5301.151815709468, 5508.91736623943, 5550.139728342114, 5681.233033540502, 408.8099033949228, 411.8599676110137, 414.5605658002527, 416.2715248315448, 417.2593646277881, 3633.4913112164318, 3666.2484190740834, 3695.833687484016, 3701.777893326409, 3748.9625103748613, 9964.302498825158, 10283.588656453658, 10363.844542331872, 10384.221183411275, 10392.844107338396, 10114.140298074599, 10215.540300686487, 10224.846627300596, 10251.333663311862, 10274.280800343904, 7199.3520583147765, 7488.887666685004, 7521.7743467696055, 7607.619619019027, 7691.30778229962, 5323.680579165262, 5358.223057656696, 5381.381141168659, 5391.892162156813, 5482.862928426821, 9221.769455763659, 9235.07649235071, 9341.626334946797, 9405.482698451651, 9443.0, 9012.143846334588, 9611.855822162534, 9622.470764107762, 9762.316637835283, 9796.069373409515, 6764.222114456704, 7055.541389809646, 7242.493025488166, 7340.926590734024, 7410.9258907412395, 7885.329746971572, 7908.6045697713735, 7954.125046244792, 7954.761357159295, 7958.164392738679, 7107.253738357398, 7173.748918787817, 7302.233265507258, 7403.111626604842, 7453.850922981402, 6814.897776533455, 6858.897116543156, 6991.475639327173, 7074.964625176841, 7081.610511421715, 6295.464885484785, 6445.581037232565, 6463.095166676575, 6470.902936456051, 6484.513661475314, 4942.703437793743, 4954.925676114934, 4965.652404331662, 4978.178600531017, 5018.949810501995, 4851.58761505276, 4893.388326459192, 4932.186189278729, 4944.604431645388, 4994.051130285234], "value": 4318.511254031897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7296857124301, 325.7475456521196, 326.0446890610513, 332.34693826630667, 332.5576982613126, 5959.761609535619, 5963.821085367441, 6084.8478788030325, 6099.420555047274, 6121.449069583737, 5975.432333928281, 5986.580939334249, 6014.849628759283, 6015.518758499309, 6068.211132552762, 4329.783510824462, 4414.426124603797, 4563.863084107482, 4578.725276483422, 4601.930971035437, 4552.4764652065105, 4560.293154561048, 4588.7246765194195, 4594.793234304464, 4596.793144308497, 4529.0, 4531.773411329436, 4573.862784116482, 4587.908241835178, 4594.885127871813, 4255.234057869582, 4448.3549885266775, 4486.753228572444, 4489.977550112261, 4492.719574921131, 3868.477755502999, 3878.1080351519026, 3887.7364856421777, 3893.4549163117185, 3903.355946268862, 5720.485156335908, 5736.2542869427125, 5739.225204597367, 5753.137029445575, 5768.971155144198, 5040.143175660147, 5138.7173705446185, 5139.10065738498, 5171.663841850268, 5181.766820493087, 6182.412670796267, 6202.131701561785, 6219.657918814463, 6230.844228894269, 6262.968685156545, 4217.261979153666, 4253.872723728215, 4275.593818587229, 4280.6361459275995, 4289.1636130954475, 6496.271565942316, 6569.967150164219, 6581.341865813428, 6590.505712071614, 6626.469882409396, 4325.718828276152, 4339.913201735948, 4347.3261644445165, 4363.2800587903275, 4378.387025816388, 4346.717463364935, 4406.691531592822, 4411.360352748833, 4430.645548356124, 4432.0, 5141.460146684619, 5152.098382782998, 5156.20078887773, 5187.377514698261, 5190.24741412493, 6294.748210071637, 6314.242290925118, 6325.652089135142, 6341.0, 6341.397567231105, 1495.1402943307423, 1515.6665533582593, 1531.7242896278776, 1533.1031346662328, 1535.8464153584775, 932.7761337279004, 981.6809536900536, 994.8159590475785, 996.5714742660581, 1006.7332156978407, 6087.239095113111, 6103.298120716175, 6119.326874043852, 6124.663143527059, 6181.876362472725, 6288.9056664150075, 6454.612723236621, 6469.353064693587, 6491.415772580491, 6495.610263384212, 5982.850428739229, 5987.790427335022, 5988.580799344091, 5990.760369585168, 5996.970015149984, 3404.4552871540436, 3422.2299982504237, 3429.2969941162, 3444.190615205425, 3459.3081383723356, 6441.162648855712, 6631.635260060646, 6805.6597170141295, 6812.48906332027, 6883.208431030395, 6668.799936001928, 6675.4325882300545, 6677.232118306457, 6683.9228070876725, 6702.262751097375, 6413.134226879405, 6651.501137414713, 6769.627670478171, 6770.424513916274, 6777.796666100025, 6440.6135631862235, 6483.675816209265, 6516.315786842503, 6524.965890860773, 6561.901571476527, 6168.8766224674355, 6460.35396460369, 6532.510061745293, 6541.247756508063, 6548.0, 6799.5920244785475, 6808.557443766139, 6811.829704257235, 6820.727170913108, 6839.418649414855, 4492.9101417970805, 4538.841140560065, 4547.840825571089, 4556.794944227584, 4562.22442184836, 6386.307628478364, 6530.412262896362, 6547.250154935034, 6555.246146693191, 6570.868582628416, 6327.778527751507, 6336.017917222838, 6367.204099487564, 6379.362063793584, 6385.744570217139, 6202.689865506797, 6223.159873417031, 6225.501959843111, 6310.242770867525, 6342.556021078481, 5923.200367950444, 6124.938750612615, 6193.163922870355, 6247.156633854554, 6264.59280146789, 6321.936780632135, 6347.270063942706, 6358.523110766619, 6370.522210834299, 6420.711068001858, 6060.090986352083, 6178.9382106180165, 6188.2883468399905, 6259.998400255937, 6261.499080073674], "value": 4721.467708223046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.9241022102898, 806.9475484093533, 811.6347643560398, 812.5124925044973, 840.1430540848331, 13145.7370852583, 13466.528671496488, 13525.526606568772, 14304.856951430482, 14443.061201021927, 13222.40499177537, 13228.801567976489, 13268.203907765517, 13312.334383280822, 13323.866761332383, 660.4452260101526, 768.5734417398342, 790.5533373643873, 791.0191362710256, 795.2008231727135, 727.8427300592058, 727.8980942668031, 730.9780706578811, 734.2253922112169, 738.5421038955828, 815.2214635023538, 818.1818181818181, 819.8401311744212, 821.4906757810166, 822.383212590557, 805.524740403165, 810.469142711522, 812.2567850416862, 813.9918600813975, 814.6944895664126, 591.3760982163816, 591.8816236752667, 592.0497601349857, 592.380961894821, 593.9554533409969, 13515.189088654712, 13603.0, 13643.38604762778, 13685.247311397869, 13698.041137120406, 13718.588442346745, 13861.79207311881, 13919.164850108924, 14065.578032658934, 14132.0, 10938.835917461245, 11043.779124417548, 11539.538418463251, 11546.94226528862, 11787.05703543723, 3849.711271654637, 3866.4973553438153, 3901.473301104343, 3909.198614284065, 3938.2320447512748, 58951.41048589502, 58986.41013589852, 59026.40973590252, 59373.0, 59738.701306493625, 9847.359921605073, 10025.699229023141, 10186.898131018743, 10321.380717156995, 10517.52671129801, 16796.58008549796, 16812.411565595146, 16843.41048063312, 16873.91563042177, 17005.404810831562, 7491.850162996819, 7527.623618819037, 7528.887066694004, 7621.733239336597, 7632.0, 4345.500267469219, 4441.0, 4441.689081764245, 4485.439320084989, 4573.977130114328, 3236.0777178504486, 3304.801711897294, 3308.387948229585, 3314.6022477302877, 3567.9108022299133, 624.0452108274347, 630.2909227119491, 634.8793729191439, 637.9521535884827, 639.114825966031, 655.672163918041, 666.5600703535644, 703.8768215562257, 707.8371974445803, 737.1927739125649, 9252.722418327327, 9253.0, 9453.574589143505, 9531.714048578553, 9592.424454532751, 578.3320265093823, 642.8842808294459, 726.2084328082416, 727.0511981863718, 736.1166600079819, 4163.063310755056, 4235.512916014698, 4346.891327716769, 4592.081583683277, 4631.212693842055, 60111.0, 60438.69780651157, 60603.48491287665, 61603.6919815407, 62070.0, 51561.48438515642, 51887.0, 52570.47429525656, 52584.0, 53172.73413632907, 36245.63754362422, 36373.45439818405, 42361.15277694429, 42949.0, 43882.0, 8813.118688131392, 8829.911700883165, 8877.112288771072, 8940.5082720451, 9117.179453849185, 31008.534871976488, 31152.376952461276, 31769.04692859218, 32237.838810805795, 33027.0, 40969.18061638691, 44274.33588496111, 45843.541564583924, 46446.767766160956, 47254.291185631555, 11237.38194399316, 11271.267367621078, 11313.434328283718, 11323.32060076398, 11695.298282103102, 12903.41934612926, 13228.735425291248, 13349.66625834362, 13495.59513214605, 14101.153930764187, 11479.770404591694, 11738.823917641072, 11752.471138798604, 12070.456829442872, 12072.698182545506, 11785.764284714429, 12163.635090947286, 12265.0, 12271.877281227431, 12300.938495307466, 12196.451159697657, 12474.937625311815, 12541.623751287476, 12969.546065888026, 13018.828305452176, 10002.749931251778, 10037.247206459691, 10052.64815731446, 10185.33795303303, 10272.537735801758, 10014.649487268201, 10063.446510441996, 10084.596616135272, 10170.694879153638, 10242.129418999468], "value": 6499.746890370205, "unit": "score"}], "name": "dromaeo_css", "value": 7008.762052040883, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 109.0, 114.0, 121.0, 109.0, 112.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 154.0, 183.0, 137.0, 174.0, 160.0, 131.0, 192.0, 133.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 161.0, 165.0, 171.0, 162.0, 166.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 156.0, 73.0, 73.0, 76.0, 77.0, 161.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 146.0, 93.0, 94.0, 92.0, 141.0, 93.0, 91.0, 140.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 148.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 100.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 61.0, 58.0, 59.0, 59.0, 58.0, 76.0, 56.0, 62.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 83.0, 92.0, 84.0, 82.0, 82.0, 82.0, 94.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 138.0, 137.0, 136.0, 137.0, 129.0, 132.0, 164.0, 136.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 169.0, 171.0, 172.0, 166.0, 172.0, 170.0, 172.0, 175.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 79.0, 68.0, 69.0, 70.0, 71.0, 69.0, 70.0, 74.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1580.3, "alertThreshold": 2.0}]} 06:06:00 INFO - Return code: 0 06:06:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:00 ERROR - # TBPL SUCCESS # 06:06:00 INFO - Running post-action listener: _resource_record_post_action 06:06:00 INFO - Running post-run listener: _resource_record_post_run 06:06:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535289856; Read time: 428; Write time: 1331948 06:06:01 INFO - install - Wall time: 18s; CPU: 19.0%; Read bytes: 0; Write bytes: 243994624; Read time: 0; Write time: 913628 06:06:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288976896; Read time: 428; Write time: 418168 06:06:01 INFO - Running post-run listener: _upload_blobber_files 06:06:01 INFO - Blob upload gear active. 06:06:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:01 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:06:01 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:06:01 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:06:01 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:02 INFO - (blobuploader) - INFO - Done attempting. 06:06:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:03 INFO - (blobuploader) - INFO - Done attempting. 06:06:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:03 INFO - Return code: 0 06:06:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eba0b4631cb3ceb65b7d1c475eba45fde2efe41a3e75b27e94a048399e64135b5fc2857e462866eb04dd2f0b38477948790d2758b4b7b224646df58df9bbf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0899053a4a6994fd2ce506aabb087dd7bcd2a7f5bd14ec6cf08c37f40b051b452115ce08968759edba3ec1e4c821e9db35160a762b4cc7e3369fa82382c80"} 06:06:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:03 INFO - Contents: 06:06:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eba0b4631cb3ceb65b7d1c475eba45fde2efe41a3e75b27e94a048399e64135b5fc2857e462866eb04dd2f0b38477948790d2758b4b7b224646df58df9bbf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0899053a4a6994fd2ce506aabb087dd7bcd2a7f5bd14ec6cf08c37f40b051b452115ce08968759edba3ec1e4c821e9db35160a762b4cc7e3369fa82382c80"} 06:06:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:03 INFO - Copying logs to upload dir... 06:06:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.558801 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-14 06:06:02.797150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 06:06:02.806440) ========= 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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 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/2eba0b4631cb3ceb65b7d1c475eba45fde2efe41a3e75b27e94a048399e64135b5fc2857e462866eb04dd2f0b38477948790d2758b4b7b224646df58df9bbf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0899053a4a6994fd2ce506aabb087dd7bcd2a7f5bd14ec6cf08c37f40b051b452115ce08968759edba3ec1e4c821e9db35160a762b4cc7e3369fa82382c80"} build_url:https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/RrNdvwu6Qre37hRzJinb2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eba0b4631cb3ceb65b7d1c475eba45fde2efe41a3e75b27e94a048399e64135b5fc2857e462866eb04dd2f0b38477948790d2758b4b7b224646df58df9bbf52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0899053a4a6994fd2ce506aabb087dd7bcd2a7f5bd14ec6cf08c37f40b051b452115ce08968759edba3ec1e4c821e9db35160a762b4cc7e3369fa82382c80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 06:06:02.830686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:06:02.830991) ========= 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=af724c981e2a0f424dbabf99000001e7-1460635989.31939-743695566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 06:06:02.913789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 06:06:02.917186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 06:06:02.917486) ========= ========= Total master_lag: 0.39 =========