builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1462012292.76 results: success (0) buildid: 20160430004057 builduid: f622e2dcb37f460a93bb132619b32a7d revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.759057) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.765434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.765755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.793592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.793874) ========= 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=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-30 03:31:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-30 03:31:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151164 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.973500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:32.973870) ========= 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=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017568 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.037812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.038191) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --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=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-30 03:31:33,659 truncating revision to first 12 chars 2016-04-30 03:31:33,659 Setting DEBUG logging. 2016-04-30 03:31:33,659 attempt 1/10 2016-04-30 03:31:33,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1347c189b6da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 03:31:34,011 unpacking tar archive at: mozilla-aurora-1347c189b6da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.691209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.691579) ========= script_repo_revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.692052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.692374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 03:31:33.715844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-30 03:31:33.716135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:34 INFO - MultiFileLogger online at 20160430 03:31:34 in /builds/slave/test 03:31:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:34 INFO - {'append_to_log': False, 03:31:34 INFO - 'base_work_dir': '/builds/slave/test', 03:31:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:34 INFO - 'branch': 'Mozilla-Aurora', 03:31:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:34 INFO - 'config_files': ('talos/linux_config.py',), 03:31:34 INFO - 'default_actions': ('clobber', 03:31:34 INFO - 'read-buildbot-config', 03:31:34 INFO - 'download-and-extract', 03:31:34 INFO - 'populate-webroot', 03:31:34 INFO - 'create-virtualenv', 03:31:34 INFO - 'install', 03:31:34 INFO - 'run-tests'), 03:31:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:34 INFO - 'download_minidump_stackwalk': True, 03:31:34 INFO - 'download_symbols': 'ondemand', 03:31:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:34 INFO - 'installer_path': 'installer.exe', 03:31:34 INFO - 'log_level': 'info', 03:31:34 INFO - 'log_name': 'talos', 03:31:34 INFO - 'log_to_console': True, 03:31:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:34 INFO - 'opt_config_files': (), 03:31:34 INFO - 'pip_index': False, 03:31:34 INFO - 'sps_profile': False, 03:31:34 INFO - 'sps_profile_interval': 0, 03:31:34 INFO - 'suite': 'dromaeojs-e10s', 03:31:34 INFO - 'system_bits': '32', 03:31:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:34 INFO - 'title': 'talos-linux64-ix-054', 03:31:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:34 INFO - 'use_talos_json': True, 03:31:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:34 INFO - 'work_dir': 'build'} 03:31:34 INFO - ##### 03:31:34 INFO - ##### Running clobber step. 03:31:34 INFO - ##### 03:31:34 INFO - Running pre-action listener: _resource_record_pre_action 03:31:34 INFO - Running main action method: clobber 03:31:34 INFO - rmtree: /builds/slave/test/build 03:31:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:35 INFO - Running post-action listener: _resource_record_post_action 03:31:35 INFO - ##### 03:31:35 INFO - ##### Running read-buildbot-config step. 03:31:35 INFO - ##### 03:31:35 INFO - Running pre-action listener: _resource_record_pre_action 03:31:35 INFO - Running main action method: read_buildbot_config 03:31:35 INFO - Using buildbot properties: 03:31:35 INFO - { 03:31:35 INFO - "project": "", 03:31:35 INFO - "product": "firefox", 03:31:35 INFO - "script_repo_revision": "production", 03:31:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:31:35 INFO - "repository": "", 03:31:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:31:35 INFO - "buildid": "20160430004057", 03:31:35 INFO - "stage_platform": "linux64-pgo", 03:31:35 INFO - "basedir": "/builds/slave/test", 03:31:35 INFO - "nightly_build": "True", 03:31:35 INFO - "buildnumber": 271, 03:31:35 INFO - "slavename": "talos-linux64-ix-054", 03:31:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:35 INFO - "platform": "ubuntu64_hw", 03:31:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:35 INFO - "branch": "mozilla-aurora", 03:31:35 INFO - "repo_path": "releases/mozilla-aurora", 03:31:35 INFO - "revision": "1347c189b6da67d2142fb266c82f74272b09139b", 03:31:35 INFO - "pgo_build": "True", 03:31:35 INFO - "builduid": "f622e2dcb37f460a93bb132619b32a7d", 03:31:35 INFO - "slavebuilddir": "test" 03:31:35 INFO - } 03:31:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:31:35 INFO - Running post-action listener: _resource_record_post_action 03:31:35 INFO - ##### 03:31:35 INFO - ##### Running download-and-extract step. 03:31:35 INFO - ##### 03:31:35 INFO - Running pre-action listener: _resource_record_pre_action 03:31:35 INFO - Running main action method: download_and_extract 03:31:35 INFO - mkdir: /builds/slave/test/build/tests 03:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:31:35 INFO - https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:44 INFO - Downloaded 1361 bytes. 03:31:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:31:44 INFO - Using the following test package requirements: 03:31:44 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:44 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:44 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:44 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'jsshell-linux-x86_64.zip'], 03:31:44 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:44 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:44 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:44 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:44 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:44 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:44 INFO - https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:50 INFO - Downloaded 23821417 bytes. 03:31:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:31:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:31:51 INFO - Return code: 0 03:31:51 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:31: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')]} 03:31:51 INFO - https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:03 INFO - Downloaded 23821417 bytes. 03:32:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:04 INFO - Return code: 0 03:32: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')]} 03:32:04 INFO - https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:06 INFO - Downloaded 10840145 bytes. 03:32:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:06 INFO - Return code: 0 03:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:06 INFO - https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:08 INFO - Downloaded 62664638 bytes. 03:32:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:08 INFO - mkdir: /builds/slave/test/properties 03:32:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:08 INFO - Contents: 03:32:08 INFO - build_url:https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:09 INFO - Running post-action listener: _resource_record_post_action 03:32:09 INFO - Running post-action listener: set_extra_try_arguments 03:32:09 INFO - ##### 03:32:09 INFO - ##### Running populate-webroot step. 03:32:09 INFO - ##### 03:32:09 INFO - Running pre-action listener: _resource_record_pre_action 03:32:09 INFO - Running main action method: populate_webroot 03:32:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:09 INFO - '--tppagecycles', 03:32:09 INFO - '7'], 03:32:09 INFO - 'tests': ['tsvgm']}}, 03:32:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['damp', 'tps']}, 03:32:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'tests': ['damp', 'tps']}, 03:32:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['dromaeo_dom']}, 03:32:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['a11yr', 03:32:09 INFO - 'ts_paint', 03:32:09 INFO - 'tpaint', 03:32:09 INFO - 'sessionrestore', 03:32:09 INFO - 'sessionrestore_no_auto_restore', 03:32:09 INFO - 'tabpaint']}, 03:32:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['tsvgx', 03:32:09 INFO - 'tsvgr_opacity', 03:32:09 INFO - 'tart', 03:32:09 INFO - 'tscrollx', 03:32:09 INFO - 'cart']}, 03:32:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:09 INFO - 'tsvgr_opacity', 03:32:09 INFO - 'tart', 03:32:09 INFO - 'tscrollx', 03:32:09 INFO - 'cart']}, 03:32:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'talos_options': ['--disable-e10s'], 03:32:09 INFO - 'tests': ['tp5o']}, 03:32:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'tests': ['tp5o']}, 03:32:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'talos_options': ['--disable-e10s', 03:32:09 INFO - '--xperf_path', 03:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:09 INFO - 'tests': ['tp5n']}, 03:32:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:09 INFO - 'talos_options': ['--xperf_path', 03:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:09 INFO - 'tests': ['tp5n']}}, 03:32:09 INFO - 'talos.zip': {'path': '', 03:32:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:09 INFO - Running post-action listener: _resource_record_post_action 03:32:09 INFO - ##### 03:32:09 INFO - ##### Running create-virtualenv step. 03:32:09 INFO - ##### 03:32:09 INFO - Running pre-action listener: _resource_record_pre_action 03:32:09 INFO - Running main action method: create_virtualenv 03:32:09 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:09 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 03:32:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:09 INFO - Using real prefix '/usr' 03:32:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:12 INFO - Installing pip.................done. 03:32:12 INFO - Return code: 0 03:32:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:12 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:12 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 03:32:12 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 03:32:12 INFO - Using env: {'DISPLAY': ':0', 03:32:12 INFO - 'HOME': '/home/cltbld', 03:32:12 INFO - 'LANG': 'en_US.UTF-8', 03:32:12 INFO - 'LANGUAGE': 'en_US:en', 03:32:12 INFO - 'LOGNAME': 'cltbld', 03:32:12 INFO - 'MAIL': '/var/mail/cltbld', 03:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:12 INFO - 'MOZ_NO_REMOTE': '1', 03:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:12 INFO - 'NO_EM_RESTART': '1', 03:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:12 INFO - 'PWD': '/builds/slave/test', 03:32:12 INFO - 'SHELL': '/bin/bash', 03:32:12 INFO - 'SHLVL': '1', 03:32:12 INFO - 'TERM': 'linux', 03:32:12 INFO - 'TMOUT': '86400', 03:32:12 INFO - 'USER': 'cltbld', 03:32:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:12 INFO - '_': '/tools/buildbot/bin/python'} 03:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:12 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 03:32:12 INFO - Cleaning up... 03:32:12 INFO - Return code: 0 03:32:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:12 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:12 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 03:32:12 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 03:32:12 INFO - Using env: {'DISPLAY': ':0', 03:32:12 INFO - 'HOME': '/home/cltbld', 03:32:12 INFO - 'LANG': 'en_US.UTF-8', 03:32:12 INFO - 'LANGUAGE': 'en_US:en', 03:32:12 INFO - 'LOGNAME': 'cltbld', 03:32:12 INFO - 'MAIL': '/var/mail/cltbld', 03:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:12 INFO - 'MOZ_NO_REMOTE': '1', 03:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:12 INFO - 'NO_EM_RESTART': '1', 03:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:12 INFO - 'PWD': '/builds/slave/test', 03:32:12 INFO - 'SHELL': '/bin/bash', 03:32:12 INFO - 'SHLVL': '1', 03:32:12 INFO - 'TERM': 'linux', 03:32:12 INFO - 'TMOUT': '86400', 03:32:12 INFO - 'USER': 'cltbld', 03:32:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:12 INFO - '_': '/tools/buildbot/bin/python'} 03:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:12 INFO - Downloading/unpacking psutil>=0.7.1 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:14 INFO - Installing collected packages: psutil 03:32:14 INFO - Running setup.py install for psutil 03:32:14 INFO - building 'psutil._psutil_linux' extension 03:32:14 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 03:32:14 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 03:32:14 INFO - building 'psutil._psutil_posix' extension 03:32:14 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 03:32:14 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 03:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:14 INFO - Successfully installed psutil 03:32:14 INFO - Cleaning up... 03:32:14 INFO - Return code: 0 03:32:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:32:14 INFO - Using env: {'DISPLAY': ':0', 03:32:14 INFO - 'HOME': '/home/cltbld', 03:32:14 INFO - 'LANG': 'en_US.UTF-8', 03:32:14 INFO - 'LANGUAGE': 'en_US:en', 03:32:14 INFO - 'LOGNAME': 'cltbld', 03:32:14 INFO - 'MAIL': '/var/mail/cltbld', 03:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:15 INFO - 'MOZ_NO_REMOTE': '1', 03:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:15 INFO - 'NO_EM_RESTART': '1', 03:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:15 INFO - 'PWD': '/builds/slave/test', 03:32:15 INFO - 'SHELL': '/bin/bash', 03:32:15 INFO - 'SHLVL': '1', 03:32:15 INFO - 'TERM': 'linux', 03:32:15 INFO - 'TMOUT': '86400', 03:32:15 INFO - 'USER': 'cltbld', 03:32:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:15 INFO - '_': '/tools/buildbot/bin/python'} 03:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32:15 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 03:32:15 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 03:32:15 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 03:32:15 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 03:32:15 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 03:32:15 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 03:32:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:32:17 INFO - Installing collected packages: mozsystemmonitor 03:32:17 INFO - Running setup.py install for mozsystemmonitor 03:32:17 INFO - Successfully installed mozsystemmonitor 03:32:17 INFO - Cleaning up... 03:32:17 INFO - Return code: 0 03:32:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:32:17 INFO - Using env: {'DISPLAY': ':0', 03:32:17 INFO - 'HOME': '/home/cltbld', 03:32:17 INFO - 'LANG': 'en_US.UTF-8', 03:32:17 INFO - 'LANGUAGE': 'en_US:en', 03:32:17 INFO - 'LOGNAME': 'cltbld', 03:32:17 INFO - 'MAIL': '/var/mail/cltbld', 03:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:17 INFO - 'MOZ_NO_REMOTE': '1', 03:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:17 INFO - 'NO_EM_RESTART': '1', 03:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:17 INFO - 'PWD': '/builds/slave/test', 03:32:17 INFO - 'SHELL': '/bin/bash', 03:32:17 INFO - 'SHLVL': '1', 03:32:17 INFO - 'TERM': 'linux', 03:32:17 INFO - 'TMOUT': '86400', 03:32:17 INFO - 'USER': 'cltbld', 03:32:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:17 INFO - '_': '/tools/buildbot/bin/python'} 03:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:20 INFO - Downloading docopt-0.6.1.tar.gz 03:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:20 INFO - Running setup.py install for blobuploader 03:32:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:20 INFO - Running setup.py install for requests 03:32:20 INFO - Running setup.py install for docopt 03:32:20 INFO - Successfully installed blobuploader requests docopt 03:32:20 INFO - Cleaning up... 03:32:20 INFO - Return code: 0 03:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:20 INFO - Using env: {'DISPLAY': ':0', 03:32:20 INFO - 'HOME': '/home/cltbld', 03:32:20 INFO - 'LANG': 'en_US.UTF-8', 03:32:20 INFO - 'LANGUAGE': 'en_US:en', 03:32:20 INFO - 'LOGNAME': 'cltbld', 03:32:20 INFO - 'MAIL': '/var/mail/cltbld', 03:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:20 INFO - 'MOZ_NO_REMOTE': '1', 03:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:20 INFO - 'NO_EM_RESTART': '1', 03:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:20 INFO - 'PWD': '/builds/slave/test', 03:32:20 INFO - 'SHELL': '/bin/bash', 03:32:20 INFO - 'SHLVL': '1', 03:32:20 INFO - 'TERM': 'linux', 03:32:20 INFO - 'TMOUT': '86400', 03:32:20 INFO - 'USER': 'cltbld', 03:32:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:20 INFO - '_': '/tools/buildbot/bin/python'} 03:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:20 INFO - Running setup.py (path:/tmp/pip-aVM55a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:20 INFO - Running setup.py (path:/tmp/pip-QtjQFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:21 INFO - Running setup.py (path:/tmp/pip-wtTDzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:21 INFO - Running setup.py (path:/tmp/pip-cycKQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:21 INFO - Running setup.py (path:/tmp/pip-ArGe5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:21 INFO - Running setup.py (path:/tmp/pip-gA1cu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:21 INFO - Running setup.py (path:/tmp/pip-704HQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:21 INFO - Running setup.py (path:/tmp/pip-XzlWox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:21 INFO - Running setup.py (path:/tmp/pip-pyjUyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:21 INFO - Running setup.py (path:/tmp/pip-vcBOFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:21 INFO - Running setup.py (path:/tmp/pip-SkCpIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:21 INFO - Running setup.py (path:/tmp/pip-kC5Kqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:21 INFO - Running setup.py (path:/tmp/pip-iwVMfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:21 INFO - Running setup.py (path:/tmp/pip-LDUL8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:21 INFO - Running setup.py (path:/tmp/pip-vQBk0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:22 INFO - Running setup.py (path:/tmp/pip-1LdKbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:22 INFO - Running setup.py (path:/tmp/pip-SZqp3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:22 INFO - Running setup.py install for manifestparser 03:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Running setup.py install for mozcrash 03:32:22 INFO - Running setup.py install for mozdebug 03:32:22 INFO - Running setup.py install for mozdevice 03:32:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Running setup.py install for mozfile 03:32:22 INFO - Running setup.py install for mozhttpd 03:32:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Running setup.py install for mozinfo 03:32:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Running setup.py install for mozInstall 03:32:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:22 INFO - Running setup.py install for mozleak 03:32:23 INFO - Running setup.py install for mozlog 03:32:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Running setup.py install for moznetwork 03:32:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Running setup.py install for mozprocess 03:32:23 INFO - Running setup.py install for mozprofile 03:32:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Running setup.py install for mozrunner 03:32:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Running setup.py install for mozscreenshot 03:32:23 INFO - Running setup.py install for moztest 03:32:23 INFO - Running setup.py install for mozversion 03:32:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:23 INFO - Cleaning up... 03:32:23 INFO - Return code: 0 03:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:23 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')]} 03:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:23 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')]} 03:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:23 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:23 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 03:32:23 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 03:32:23 INFO - Using env: {'DISPLAY': ':0', 03:32:23 INFO - 'HOME': '/home/cltbld', 03:32:23 INFO - 'LANG': 'en_US.UTF-8', 03:32:23 INFO - 'LANGUAGE': 'en_US:en', 03:32:23 INFO - 'LOGNAME': 'cltbld', 03:32:23 INFO - 'MAIL': '/var/mail/cltbld', 03:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:23 INFO - 'MOZ_NO_REMOTE': '1', 03:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:23 INFO - 'NO_EM_RESTART': '1', 03:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:23 INFO - 'PWD': '/builds/slave/test', 03:32:23 INFO - 'SHELL': '/bin/bash', 03:32:23 INFO - 'SHLVL': '1', 03:32:23 INFO - 'TERM': 'linux', 03:32:23 INFO - 'TMOUT': '86400', 03:32:23 INFO - 'USER': 'cltbld', 03:32:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:23 INFO - '_': '/tools/buildbot/bin/python'} 03:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:24 INFO - Running setup.py (path:/tmp/pip-8QCdjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:24 INFO - Running setup.py (path:/tmp/pip-hrz1Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:24 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)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:24 INFO - Running setup.py (path:/tmp/pip-SuGXbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:24 INFO - Running setup.py (path:/tmp/pip-R219pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:24 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)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:24 INFO - Running setup.py (path:/tmp/pip-zJDnOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:24 INFO - Running setup.py (path:/tmp/pip-BEQhlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:24 INFO - Running setup.py (path:/tmp/pip-ylAeI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:24 INFO - Running setup.py (path:/tmp/pip-4JsWs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:24 INFO - Running setup.py (path:/tmp/pip-rMwNTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:24 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)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:24 INFO - Running setup.py (path:/tmp/pip-GRxEi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:24 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)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:24 INFO - Running setup.py (path:/tmp/pip-gcLxhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:24 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)) 03:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:24 INFO - Running setup.py (path:/tmp/pip-lydlTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:25 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)) 03:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:25 INFO - Running setup.py (path:/tmp/pip-FDlru_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:25 INFO - Running setup.py (path:/tmp/pip-Qvb7f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:25 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)) 03:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:25 INFO - Running setup.py (path:/tmp/pip-aguCpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:25 INFO - Running setup.py (path:/tmp/pip-PADmgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:25 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)) 03:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:25 INFO - Running setup.py (path:/tmp/pip-fQoE80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:27 INFO - Downloading blessings-1.6.tar.gz 03:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:27 INFO - Installing collected packages: blessings 03:32:27 INFO - Running setup.py install for blessings 03:32:27 INFO - Successfully installed blessings 03:32:27 INFO - Cleaning up... 03:32:27 INFO - Return code: 0 03:32:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:27 INFO - Reading from file tmpfile_stdout 03:32:27 INFO - Current package versions: 03:32:27 INFO - argparse == 1.2.1 03:32:27 INFO - blessings == 1.6 03:32:27 INFO - blobuploader == 1.2.4 03:32:27 INFO - docopt == 0.6.1 03:32:27 INFO - manifestparser == 1.1 03:32:27 INFO - mozInstall == 1.12 03:32:27 INFO - mozcrash == 0.17 03:32:27 INFO - mozdebug == 0.1 03:32:27 INFO - mozdevice == 0.48 03:32:27 INFO - mozfile == 1.2 03:32:27 INFO - mozhttpd == 0.7 03:32:27 INFO - mozinfo == 0.9 03:32:27 INFO - mozleak == 0.1 03:32:27 INFO - mozlog == 3.1 03:32:27 INFO - moznetwork == 0.27 03:32:27 INFO - mozprocess == 0.22 03:32:27 INFO - mozprofile == 0.28 03:32:27 INFO - mozrunner == 6.11 03:32:27 INFO - mozscreenshot == 0.1 03:32:27 INFO - mozsystemmonitor == 0.0 03:32:27 INFO - moztest == 0.7 03:32:27 INFO - mozversion == 1.4 03:32:27 INFO - psutil == 3.1.1 03:32:27 INFO - requests == 1.2.3 03:32:27 INFO - wsgiref == 0.1.2 03:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:27 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:27 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 03:32:27 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 03:32:27 INFO - Using env: {'DISPLAY': ':0', 03:32:27 INFO - 'HOME': '/home/cltbld', 03:32:27 INFO - 'LANG': 'en_US.UTF-8', 03:32:27 INFO - 'LANGUAGE': 'en_US:en', 03:32:27 INFO - 'LOGNAME': 'cltbld', 03:32:27 INFO - 'MAIL': '/var/mail/cltbld', 03:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:27 INFO - 'MOZ_NO_REMOTE': '1', 03:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:27 INFO - 'NO_EM_RESTART': '1', 03:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:27 INFO - 'PWD': '/builds/slave/test', 03:32:27 INFO - 'SHELL': '/bin/bash', 03:32:27 INFO - 'SHLVL': '1', 03:32:27 INFO - 'TERM': 'linux', 03:32:27 INFO - 'TMOUT': '86400', 03:32:27 INFO - 'USER': 'cltbld', 03:32:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:27 INFO - '_': '/tools/buildbot/bin/python'} 03:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 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)) 03:32:27 INFO - Cleaning up... 03:32:27 INFO - Return code: 0 03:32:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:27 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:27 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 03:32:27 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 03:32:27 INFO - Using env: {'DISPLAY': ':0', 03:32:27 INFO - 'HOME': '/home/cltbld', 03:32:27 INFO - 'LANG': 'en_US.UTF-8', 03:32:27 INFO - 'LANGUAGE': 'en_US:en', 03:32:27 INFO - 'LOGNAME': 'cltbld', 03:32:27 INFO - 'MAIL': '/var/mail/cltbld', 03:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:27 INFO - 'MOZ_NO_REMOTE': '1', 03:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:27 INFO - 'NO_EM_RESTART': '1', 03:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:27 INFO - 'PWD': '/builds/slave/test', 03:32:27 INFO - 'SHELL': '/bin/bash', 03:32:27 INFO - 'SHLVL': '1', 03:32:27 INFO - 'TERM': 'linux', 03:32:27 INFO - 'TMOUT': '86400', 03:32:27 INFO - 'USER': 'cltbld', 03:32:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:27 INFO - '_': '/tools/buildbot/bin/python'} 03:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:28 INFO - Downloading/unpacking jsonschema 03:32:28 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 03:32:28 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 03:32:28 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 03:32:28 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 03:32:28 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 03:32:28 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 03:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:29 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32:29 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 03:32:29 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 03:32:29 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 03:32:29 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 03:32:29 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 03:32:29 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 03:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:30 INFO - warning: no files found matching '*.txt' 03:32:30 INFO - no previously-included directories found matching 'build' 03:32:30 INFO - no previously-included directories found matching 'dist' 03:32:30 INFO - no previously-included directories found matching '.git*' 03:32:30 INFO - Installing collected packages: jsonschema, functools32 03:32:30 INFO - Running setup.py install for functools32 03:32:30 INFO - warning: no files found matching '*.txt' 03:32:30 INFO - no previously-included directories found matching 'build' 03:32:30 INFO - no previously-included directories found matching 'dist' 03:32:30 INFO - no previously-included directories found matching '.git*' 03:32:30 INFO - Successfully installed jsonschema functools32 03:32:30 INFO - Cleaning up... 03:32:30 INFO - Return code: 0 03:32:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:30 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 0x7fce9ce62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', '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 03:32:30 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 03:32:30 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 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:30 INFO - Downloading/unpacking flake8 03:32:30 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 03:32:30 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 03:32:30 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 03:32:30 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 03:32:30 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 03:32:30 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 03:32:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:32 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 03:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:33 INFO - no previously-included directories found matching 'docs/_build' 03:32:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:33 INFO - Running setup.py install for pep8 03:32:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:33 INFO - no previously-included directories found matching 'docs/_build' 03:32:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:32:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:33 INFO - Cleaning up... 03:32:33 INFO - Return code: 0 03:32:33 INFO - Running post-action listener: _resource_record_post_action 03:32:33 INFO - Running post-action listener: _start_resource_monitoring 03:32:33 INFO - Starting resource monitoring. 03:32:33 INFO - ##### 03:32:33 INFO - ##### Running install step. 03:32:33 INFO - ##### 03:32:33 INFO - Running pre-action listener: _resource_record_pre_action 03:32:33 INFO - Running main action method: install 03:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:33 INFO - Reading from file tmpfile_stdout 03:32:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:33 INFO - Reading from file tmpfile_stdout 03:32:33 INFO - Output received: 03:32:33 INFO - Usage: mozinstall [options] installer 03:32:33 INFO - Options: 03:32:33 INFO - -h, --help show this help message and exit 03:32:33 INFO - -d DEST, --destination=DEST 03:32:33 INFO - Directory to install application into. [default: 03:32:33 INFO - "/builds/slave/test"] 03:32:33 INFO - --app=APP Application being installed. [default: firefox] 03:32:33 INFO - mkdir: /builds/slave/test/build/application 03:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:32:49 INFO - Reading from file tmpfile_stdout 03:32:49 INFO - Output received: 03:32:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:49 INFO - Running post-action listener: _resource_record_post_action 03:32:49 INFO - ##### 03:32:49 INFO - ##### Running run-tests step. 03:32:49 INFO - ##### 03:32:49 INFO - Running pre-action listener: _resource_record_pre_action 03:32:49 INFO - Running main action method: run_tests 03:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:49 INFO - Python 2.7.3 03:32:49 INFO - Return code: 0 03:32:49 INFO - grabbing minidump binary from tooltool 03:32:49 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')]} 03:32:49 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 0x2137410>, '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 0x2138310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21387a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:49 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 03:32:49 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 03:32:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:49 INFO - Return code: 0 03:32:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:50 INFO - Return code: 0 03:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 03:32:50 INFO - Using env: {'DISPLAY': ':0', 03:32:50 INFO - 'HOME': '/home/cltbld', 03:32:50 INFO - 'LANG': 'en_US.UTF-8', 03:32:50 INFO - 'LANGUAGE': 'en_US:en', 03:32:50 INFO - 'LOGNAME': 'cltbld', 03:32:50 INFO - 'MAIL': '/var/mail/cltbld', 03:32:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:50 INFO - 'MOZ_NO_REMOTE': '1', 03:32:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:50 INFO - 'NO_EM_RESTART': '1', 03:32:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:50 INFO - 'PWD': '/builds/slave/test', 03:32:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:50 INFO - 'SHELL': '/bin/bash', 03:32:50 INFO - 'SHLVL': '1', 03:32:50 INFO - 'TERM': 'linux', 03:32:50 INFO - 'TMOUT': '86400', 03:32:50 INFO - 'USER': 'cltbld', 03:32:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689', 03:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:50 INFO - '_': '/tools/buildbot/bin/python'} 03:32:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:32:50 INFO - mozversion application_buildid: 20160430004057 03:32:50 INFO - mozversion application_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 03:32:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:50 INFO - mozversion application_name: Firefox 03:32:50 INFO - mozversion application_remotingname: firefox-dev 03:32:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:50 INFO - mozversion application_vendor: Mozilla 03:32:50 INFO - mozversion application_version: 48.0a2 03:32:50 INFO - mozversion platform_buildid: 20160430004057 03:32:50 INFO - mozversion platform_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 03:32:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:50 INFO - mozversion platform_version: 48.0a2 03:32:50 INFO - using testdate: 1462012370 03:32:50 INFO - actual date: 1462012370 03:32:50 INFO - starting webserver on 'localhost:40856' 03:32:50 INFO - SUITE-START | Running 2 tests 03:32:50 INFO - TEST-START | dromaeo_css 03:32:50 INFO - operating with platform_type : linux_ 03:32:50 INFO - Initialising browser for dromaeo_css test... 03:32:50 INFO - TEST-INFO | started process 23652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepZFxl/profile http://localhost:40856/getInfo.html) 03:32:54 INFO - PROCESS | 23652 | 03:32:54 INFO - PROCESS | 23652 | (process:23733): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:32:55 INFO - PROCESS | 23652 | __metrics Screen width/height:1600/1200 03:32:55 INFO - PROCESS | 23652 | colorDepth:24 03:32:55 INFO - PROCESS | 23652 | Browser inner width/height: 1024/697 03:32:55 INFO - PROCESS | 23652 | __metrics 03:32:55 ERROR - PROCESS | 23652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:32:56 INFO - TEST-INFO | 23652: exit 0 03:32:56 INFO - Browser initialized. 03:32:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:56 INFO - TEST-INFO | started process 23784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepZFxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:58 INFO - PROCESS | 23784 | 03:32:58 INFO - PROCESS | 23784 | (process:23853): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:33:08 INFO - PROCESS | 23784 | RSS: Main: 152383488 03:33:08 INFO - PROCESS | 23784 | 03:33:58 INFO - PROCESS | 23784 | 1462012438197 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] 03:36:05 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40856/tests/dromaeo/cssquery-ext.html) 03:36:06 INFO - PROCESS | 23784 | RSS: Main: 155283456 03:36:06 INFO - PROCESS | 23784 | 03:39:08 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-ext.html (next: http://localhost:40856/tests/dromaeo/cssquery-jquery.html) 03:39:09 INFO - PROCESS | 23784 | RSS: Main: 154406912 03:39:09 INFO - PROCESS | 23784 | 03:42:11 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40856/tests/dromaeo/cssquery-mootools.html) 03:42:11 INFO - PROCESS | 23784 | RSS: Main: 153833472 03:42:11 INFO - PROCESS | 23784 | 03:45:13 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40856/tests/dromaeo/cssquery-prototype.html) 03:45:13 INFO - PROCESS | 23784 | RSS: Main: 153628672 03:45:13 INFO - PROCESS | 23784 | 03:48:16 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40856/tests/dromaeo/cssquery-yui.html) 03:48:17 INFO - PROCESS | 23784 | RSS: Main: 155213824 03:48:17 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | Cycle 1(1): loaded http://localhost:40856/tests/dromaeo/cssquery-yui.html (next: http://localhost:40856/tests/dromaeo/cssquery-dojo.html) 03:51:19 INFO - PROCESS | 23784 | RSS: Main: 156221440 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | __start_tp_report 03:51:19 INFO - PROCESS | 23784 | _x_x_mozilla_page_load 03:51:19 INFO - PROCESS | 23784 | _x_x_mozilla_page_load_details 03:51:19 INFO - PROCESS | 23784 | |i|pagename|runs| 03:51:19 INFO - PROCESS | 23784 | |0;dojo.html;3327.234736010718;3398;3427.7943323400614;3461.4980827779955;3466.012186526839;5768.134779783029;5774.469765512143;5785.334686511042;5797.217375654285;5849.151872978416;5704.828855134342;5790.913136302948;5797.797077102302;5811.535077193825;5822.767089316433;5192.376914770223;5227.294315267447;5276.762545685453;5313.521783039526;5349.839504814861;5109.923351149717;5207.4792520747815;5357.973210133963;5368.46315368462;5382.730863456831;5183.585313174955;5208.5051920067535;5219.530242278194;5233.712145831978;5242.344706911636;5236.738163091849;5268.6575372600655;5268.683878967255;5283.498067683564;5313.468653134656;4985.975070124662;5072.213806859942;5127.077126117298;5151.665141765773;5158.92261616076;5534.308211473566;5539.307586551681;5552.77788888444;5580.637258578179;5625.240592520039;6075.2405949256345;6102.450779429828;6105.8168254952425;6113;6155.815325540196;5951;6116.388361163892;6159.938400616026;6178.10417489466;6219.129321894939;5708.828735137952;5710.71446427677;5717.742701578397;5736.569757268222;5756.942430575725;6235.282942461675;6254.437100660963;6254.749810007549;6255.218097737783;6256.781012664626;5833.183354330397;5931.6441013539325;5968.522518198533;5987.191729116601;5993.880122397615;6034.788782392595;6072.423119803611;6081.969590152021;6093.26880774301;6101;5993.250843644544;6024.909626355608;6026.126211699279;6057.212562366953;6058.606190597597;5992.520598352121;6017.2779266488305;6043.667598282049;6056.515478761777;6067.7269522871575;4595.241785105421;4611.146937816515;4612.146752850734;4620.214563524209;4649.697769644962;4038.3134867072667;4096.365063415115;4101.405296232089;4157.168566286755;4180.623743863067;5758.2514273144225;5797.4782269595935;5839;5846.327672317653;5900.262467191601;6159.443701630747;6190.535709821781;6210.192674952227;6214.347493513206;6215.098810672427;5780.364159942403;5875.353711091777;5933.970330148408;5956.583039187302;5996.580239383201;5050.823221187241;5050.84847454577;5081.8729531762;5090.49095090488;5109.514596113363;6264.248290205204;6278.748850046039;6281.214848143982;6298.811035668938;6299.968500157562;6010.699465026819;6092.969535152296;6093;6116.396640261158;6121.938780612315;6365.7135428904885;6367.076773867856;6367.586106903036;6381.968090159519;6398.936010639834;6085.513158947185;6090.786822461193;6096.847578810565;6097.939020609737;6104.786332478342;5933.317668468181;6137.140800287874;6192.752289908353;6197.721102550487;6203.379662033761;5962.642241465526;6003.159557662018;6009.308929473166;6026.216591843032;6036.245469316335;5955.642661440327;5996.67018313997;6008;6015.639061656315;6038.305594856648;5635.182898479616;5747.74135163927;5806.44838740319;5845.795397161079;5878.177055212188;6085.208922840003;6107.725152368243;6123.234595675541;6132.693365331805;6140.355262697352;5857.0043092673495;5949.434803693643;5959.582829201914;5965;5968.552358573212 03:51:19 INFO - PROCESS | 23784 | |1;ext.html;657.7927952694904;660.6267458885729;676.5737585321249;720.1933834105803;746.7125156814626;37325;40747;41438.378424323586;41844.372334415006;42046;46091.53908460923;47099;47579.28631070536;47768.52231477684;47839.52160478394;9078.046805085487;9298.72103836886;9317.301202409812;9336.953315233415;9354.625814967394;8964.327675424336;9093.590788414538;9136.314776391764;9197.586108625095;9217.124373184537;9116.635334586641;9261.907380926206;9266.212371948392;9283.535823208846;9310;9117.68088116916;9158.862617060682;9171.99108098112;9181.632734690604;9218;9061.275097992146;9117.17945384912;9170.541472926327;9185.265178785681;9224.169824715807;43039.784801075795;43662.781686091366;43792;43957;44019;3885.5337359516757;3897.1424597793844;3931.5085614298214;3982.1239327348226;4069.552349241581;32916.177095572566;33295.33409331824;33659;33894.49158262628;34098;4472.910541789146;4543.091381723635;4559.908801823978;4568.337591049312;4577.793999270041;344548.2772586146;344704;344752;345760;348059;65617.6719116411;66469.66765166144;66635.33364666291;66681;66730.33269667241;62389.68805155945;63428.36571634225;63517.364826352066;63572.68213658902;63643;18888.24447022131;19032.904835476013;19058.809411905702;19094.2362305509;19149;14885.404583816742;14910.25448727581;14950.252487375588;14991.775123373158;15028.774568381483;20487.8975605121;20738;20830.37508874736;21423.46441338979;21595;7724.382049436032;7737.645911965384;7742.6902923883545;7780.105287891852;7832.295093441618;1097.7694684116425;1145.7536629624503;1157.4444266752007;1194.2595590733627;1214.9149559530924;32927.176820579196;33287;33507.49738753921;33977.83011084978;34001.14997125092;1179.6755892129734;1192.7077865922904;1218.7440637466232;1225.3628113381171;1227.2759072147476;17715.822841771416;18024.279028838962;18052.63894722098;18134.727979080326;18229.635407292044;317031;321311;321933;407161;505173;58714.11928821071;59553.40446595565;59619.70190149022;59781;60012.39987600155;1509.124707669549;1511.5843143135726;1514.606202387365;1523.8476152384894;1614.039646410384;30275.848620756755;31233.06300810979;31422;32033.359332813678;32290.35419291648;51545.48454515407;52826;52964;52968.20547691711;55735.16397254125;454480;459577;459619;462554;463920;46831.29753053775;47160.66620125606;47820;47833;48133;53760.46239537711;54174.45825541694;55141.72429137828;55850.72074639601;56122;43689.78155109204;44683;44917.101657966006;45493.31760023536;46233.76883115563;38105.61894381021;40109.59890401176;43924.56075439205;44154.77922610495;46119.3082103762;39204.803975979936;39737.40393894152;39831.402528962666;40311.39532907067;40976.38535422031;33648.49527257044;33739.662603373654;34285.48571771475;34305.79929702448;34613.13467163341;26558.203253902415;26809;27324;27462.45075098447;27800.860995694893 03:51:19 INFO - PROCESS | 23784 | |2;jquery.html;415.7775590059319;418.8157210827236;429.83666206841394;433.17047853360816;433.6920786241768;18690;18710.71933920992;19330.613387732235;20650.690239646417;20769.27307544236;18380.81619183808;18491.445256642288;19264.614707705874;19293.903530482363;19423.51441213967;5222.8694282642955;5388.78444862205;5433.673979561219;5445.264889239961;5457.481539253785;5269.76286067126;5399.514043736063;5504.64219825712;5513.2005859150395;5513.696746678931;5503;5507.421720719327;5517.393086760453;5518.365387980393;5520.337559492847;5489.1217405215175;5615.887682246353;5788.7684492620665;5808.128780682931;5857.355690874022;5593.105103183511;5653.943460565424;5694.77220911163;5864.76540938362;5909.379515150933;13712.794308085387;13921.095128816594;14169.220692861889;14315.713685726332;14436.855631443761;2445.8287919845616;2460.5940019896875;2505.649209110726;2523.5331463679277;2650.4566563854364;10081.546330415149;10623.36259824413;10710.785784284348;10734.892651073545;10931.234813563055;2043.632146213681;2103.63186442372;2122.628540005493;2205.128974055255;2206.30501392061;87943.56028219817;91082.5445872773;91260.54369728176;91846.5407672964;91871.54064229703;10896.891031089746;11340.773184536429;11873.940630296793;12064.457099430547;12189.329586872807;15162.924185379003;17130.057846818294;17150.914245428943;17221.225044873012;17244.655106897793;7998.480098793676;8213;8269.95865020683;8316.916830831615;8437.831243375098;7995.960020199978;8007.678733008988;8068.193180681885;8165.387595930329;8225.506469611722;5057.241413787961;5141.691498510101;5188.325517682677;5194.3766747990485;5230.006298803215;2128.70198172256;2152.171414005619;2162.470194802252;2175.282156888223;2188.0591345721173;1003.8042581696645;1055.5091882274778;1056.0864851903202;1065.3980501016902;1082.3397727386289;19317.22731090769;19487.610247794964;19503.512412189808;19593.804061959483;19920.3027894023;1131.536070211226;1140.0594509529672;1144.959926402572;1154.440096553171;1204.1450570095155;11000.009999100119;11020.779584408427;11053.834192486958;11058.22592418539;11139.665810025712;368696;368894;369663;372276;418431;99825.50087249518;100601.49699251457;103464.48267758764;103573;106216.46891765491;1126.3748619516084;1167.8131498960126;1176.7822952753768;1179.722765150189;1180.2151569206553;17850.732239016164;18033.819661803213;18076.276948921895;18253;18328.81671183271;39965.60034399735;40894;43318.35022474602;43332.566674332855;43834;53886.73056634849;55098;56606.43393566012;57295.14057289228;57838.7108064457;5767.826965191051;8460.365472589458;8535.487870727777;9036.59335329925;9070.773230669287;12476.376181191086;13517.053806233469;13716.24560649134;13821;14120.50578229757;12403.379831008593;12413.069019823368;12496.93751531273;12654.43055062506;12809.679758006125;11300.830487542858;11637.76724465489;11643.59247426336;12341.01271898228;12386.194897331645;6366.586171898812;10719.946400267949;12391.504339826306;12460.813087803508;12674.873251267738;9219.631214751334;9269;9334.579943902405;9340.252779777466;9373.437593744397;9487.810243795224;12387.442565084413;12496.437660305126;12681.365931703562;12724.491020359083 03:51:19 INFO - PROCESS | 23784 | |3;mootools.html;1492.9402823887042;1573.6852629474104;1763.5326638440808;1869.2055876252598;1917.6452356314092;7861;8406.831863362737;8507.659693612248;8804.691835785748;8859.867101993475;8468.745937621881;8482.448640838342;8562.229399354072;8569;8581.95709021454;2436.390902274436;2473.88867500962;2483.3046746910895;2495.7878580320694;2500.2624225853415;2325.162941341116;2424.381782645423;2427.3688840901405;2451.8528888266674;2452.448199155194;2433.6714543536573;2458.4345600511892;2506.1604362538574;2507.862067586282;2515.5723527000364;2233.218373569254;2243.4279258789065;2247.191011235962;2295.127851416468;2326.5114325991563;2385.7256415512265;2398.988005059981;2399.7600239976036;2422.358075110097;2446.449548851512;8649.65401383944;8699.434536755154;8727.519986400745;8734.73795786121;8734.912650873473;5398.24424580559;5644.238027866227;5647.209390685307;5656.773729050833;5657.321121465409;3576.8211589420685;3599.6040435552068;3682.6685598296012;3705.055210921225;3789.905252368713;1142.7885841119419;1165.044663376032;1176.688177632928;1188.5661733467223;1195.7429152732118;12075.033997280196;12081.456334464881;12165.695857603541;12166.391680416033;12234;4887.65786394956;4955.231939049453;4959.305697202394;4963.975180124148;5077.086124497552;10210.387376757419;10306.690799276033;10325.690229292983;10404.68785936423;10404.895951040393;5561.4716601922755;5640.802571910045;5672.716364181857;5686.260786097863;5692.772289108472;4508.639308855284;4910.21436570147;5000.724960127228;5053.0399224147295;5271.1302635064785;4219.535851056381;4223.66210703143;4309.181255561496;4310.353446982977;4333.306670932636;1397.832809603992;1402.502111750314;1406.585057408067;1408.295852073963;1411.0968979852903;941.4868896451451;1058.074185088048;1074.1245884604023;1079.96220132295;1083.7019819549687;5963.5527335450015;6059.242594675666;6062.605930614496;6105.084237364431;6237.0020796673225;473.03028790978357;482.55604843544023;514.765781569385;519.0708631549484;522.7804322184692;4271.786410679516;4290.249206388869;4296.2481565725875;4330.242207613655;4342.630876375543;10409.5836166554;10739.624113156002;10814.94592527048;10834.891651083388;10953.452327383759;10621.787564248672;10674.466276686135;10744.785104297871;10803;10815;7841.725539606086;7951.602419878983;7962.56205908669;7986.840263194704;8000.119986801564;5916.290045194604;5983.58114931968;6079.045488441461;6104.847378815565;6223.719932603134;9594.42433453995;10020.599176032876;10041.698749037541;10235.078842904175;10239.7440063999;10223.079922806983;10362.171026318027;10431.269811113149;10460.947695261779;10524.105451036748;7577.772666820004;7729.111152217342;7774.572398518136;7835.882461762964;7876.173001834954;8338.791530211793;8420.957895210484;8464.407491475538;8497.957510212409;8508.191721786421;7405.407567394704;7642.388608911163;7661.195574464601;7688.807779805549;7690.346320562591;7450.254974502506;7531.435142364235;7552.244775522404;7610.961945190239;7634.885476717965;7327.63361831917;7392.519486233377;7408.518446301189;7412.073490813648;7432.962835186006;5239.580833533232;5324.574034077187;5429.375621803543;5429.538489228302;5460.672359658433;5099.260607212008;5197.194434862602;5244.947550524446;5289.814856480005;5308.124159513637 03:51:19 INFO - PROCESS | 23784 | |4;prototype.html;340.5776836722464;342.5290225939332;347.58984398409865;347.8017530007895;352.9841157147929;5811.5641326900495;5853.326867410249;5871.76512939483;5878.177055212263;5883.352831188571;5682.147677848315;5720.342160651527;5728.198052272685;5762.193292938992;5766.308043034842;4032.717709760318;4304.182205380983;4421.447319085114;4482.327650852382;4488.371627972087;4410.514843367227;4450.488193857699;4461.196984542781;4468.932966005513;4483.5964763171305;4451.5103338632725;4504.121696269229;4517.728936263835;4517.954820451802;4527.637788976874;4425.955740442602;4454.28731402974;4460.241758900995;4502.2571275739465;4506.594406503414;3934.252492026506;3938.6455219030427;3965.6827453803626;3966.107625784204;3969.206158768258;5482.396936337;5498.285222921035;5514.862128446781;5546.556275497991;5550.69471179085;5037.848864534069;5040.798368065273;5114.335136432277;5126.282320475137;5162.148245539482;5922.97038514809;5956.821295361146;5985.461308482258;5989.8203053908455;6027.246594175728;4346.673999450022;4387.354741971761;4412.977935110336;4423.4912985006495;4430.29115341547;5893.7053147342895;6095.878082438371;6227.3772622737815;6260;6284.465820405271;4377.4528183977;4396.516383197845;4408.206522825923;4409.647228221735;4417.823287068545;4450.332450132441;4457.665675074382;4477.910441791211;4493.932591011137;4496.865094047183;4959.479254678279;5074.695518268915;5101.2603172539775;5105.974470127626;5135.666181698178;6050.969745151334;6072.878542429126;6083.7870674526175;6088.459501853292;6126.78556250538;1634.133909028193;1635.386729976259;1639.319682331819;1643.9753403698953;1647.5881029742563;1045.6026709850207;1070.9303895246785;1077.8975997280245;1094.1465656787718;1112.1047556716758;6218.875622487525;6266.530010249249;6273.153124328157;6275.874482510324;6296.937030629727;6628.635425051669;6638.96680516604;6645.501587380966;6672.699728512229;6682.565633233921;5713.171590119409;6050.48570871472;6057.848553786191;6067.453929146398;6083.422074902877;3622.836972336251;3627.619099994515;3628.1473853644375;3632.7457078004813;3634.23681026982;6810.353016463428;6959.22468495403;7013.544119632207;7018.438524917994;7026.543274687129;6863.862722745617;6897.3447522485285;6915.51591388598;6923.2038315593345;6942.93057069433;6798.592084474947;6930.480213983971;7004.789856304319;7075.257098004636;7079.221285658574;6623.3376662333385;6691.966540167268;6779.457643388616;6794.116764820542;6797.694103765243;5887.911681324869;6406.807795765948;6677.959834300178;6678.666066696743;6724;6191.721372538336;6467.579607325509;6472.967635161794;6474.967625162032;6508.739650413931;4305.146893530336;4310.2457070012;4314.878131685847;4320.805563749702;4329.177456283422;5998.3401825798255;6295.9370406297185;6337.04944258365;6350.682465876595;6356.237251529846;6147.754089836357;6180.721867515883;6193.040078787795;6201.627902325875;6210.844728881814;6013.294017692144;6024.277086749618;6135.662538560422;6145.0028740660355;6175.505959523317;5958.9869722148205;5969.940300597113;5987.520998320037;6002.429769171922;6045.395460453919;6168.568200226121;6183.691724927143;6195.721192546256;6248.281447633399;6265.749370025148;5871.5027667944405;5896.204012458435;6004.459598636144;6027.427394397525;6031.879362412815 03:51:19 INFO - PROCESS | 23784 | |5;yui.html;845.5476320168711;857.0829212742366;918.8254231695973;920.558132096594;924.440713368412;14495.927520362397;14955.10269383835;14973.47592834251;14983.625409364771;15034.398624055038;12729.363531823417;14688.559343219693;14700.044497107681;14728.410863565472;14763.261836908165;860.0453496618763;872.9301655867547;873.1835733589114;879.1955360844819;881.2597418168737;883.5052370672412;883.6553744039829;885.0308911741632;889.204162274767;899.9235065019482;939.4879790514186;942.4015749998731;946.7443790176649;951.210495288912;951.5147274889787;937.292344280071;939.7556635274809;940.5720397219249;944.1785646487531;945.5886689290112;693.1370443797454;694.2155364438203;695.8260434891278;697.0554898113035;699.1959246866094;14856.777148342784;15060.698786024328;15138.091714497166;15145.697086058328;15185.848141518554;14972.17653029083;15053.172075535842;15075.698486030327;15219.315130819139;15250.694986100327;11560;11603.4198290086;11638.359890206035;11768.882311176863;11775.999040081604;4000.959990400117;4021.1008261172315;4092.283850326181;4114.897127571805;4123.113530590907;53149.468505314835;53283.73358133184;54003.919921601744;54270;54802.72598637021;12005.579804706793;12017.33904635236;12059.336736479578;12076.562655767051;12086.697832554257;20521.17915283372;20540.691889621667;20566.280180193622;20724.58550828975;20873.582528349347;8780.692675756318;8783.912160878437;8879.556022198864;8899.73300800977;8951.060138685345;4809.879753006203;4894.216925291937;4952.034353301072;4952.666416885226;4977;3502.4571191465366;3608.2422691235133;3608.566971963381;3612.8012959287494;3615.8192090395373;605.6699098991061;678.1997243252911;682.7337338438014;683.2313647146959;683.9931600684029;652.1652285075112;779.3842864137268;783.2637320918318;798.7843282313859;812.1959260332228;9397;9984.301098923152;10246.795064098676;10381.532831022621;10599.364038157735;760.5512747478904;792.0455850699893;792.2473650032492;796.3231253434534;827.8882350882674;4782.593479554277;4839.758012099381;4905.2151655734915;4948;4948.727819969936;64112.35887641157;66331.66834165798;66455;66541.66729166324;66595;60893;62811;63595.36404635895;63621;64133.358666413675;54339.18491222714;55189.44810551843;55233.72383138139;55606.443935560936;55961;9278.62885484573;9332.30007749435;9532.95233523828;9587.328886977844;9710.514474276399;36735.63264367322;36910.63089369072;37397.81301093477;37595.62404375921;38468.807655961544;46932.53067469282;48953.5104648949;49436.75281623569;49497.75251123722;50028.749856250484;12129.454174562343;12228.388580571114;12321.691957701129;12442.937785311016;12721.109522333718;12957.41691623898;13486;13637.522686705917;13677.931610341884;13805.930970345486;12222.022238220743;12264;12498.562550310695;12626.305553194663;12787.488500459878;11981.041516678819;12202.084843636585;12387.504499820267;12839;13026.674333141747;12383.75232495327;12522.812157817458;12641.304728240035;13253.668658283234;13261;10983.176261780558;11008.119350451785;11129.777404452028;11417.429128543707;11751.706207344885;11483.196176267582;12176.634700958986;12363.93818030904;12400.379981001095;12497.56258530947 03:51:19 INFO - PROCESS | 23784 | __end_tp_report 03:51:19 INFO - PROCESS | 23784 | __start_cc_report 03:51:19 INFO - PROCESS | 23784 | _x_x_mozilla_cycle_collect,324 03:51:19 INFO - PROCESS | 23784 | __end_cc_report 03:51:19 INFO - PROCESS | 23784 | __startTimestamp1462013479507__endTimestamp 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | ------- Summary: start ------- 03:51:19 INFO - PROCESS | 23784 | Number of tests: 6 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#0] dojo.html Cycles:165 Average:5684.30 Median:5949.43 stddev:644.51 (10.8%) stddev-sans-first:619.39 03:51:19 INFO - PROCESS | 23784 | Values: 3327.2 3398.0 3427.8 3461.5 3466.0 5768.1 5774.5 5785.3 5797.2 5849.2 5704.8 5790.9 5797.8 5811.5 5822.8 5192.4 5227.3 5276.8 5313.5 5349.8 5109.9 5207.5 5358.0 5368.5 5382.7 5183.6 5208.5 5219.5 5233.7 5242.3 5236.7 5268.7 5268.7 5283.5 5313.5 4986.0 5072.2 5127.1 5151.7 5158.9 5534.3 5539.3 5552.8 5580.6 5625.2 6075.2 6102.5 6105.8 6113.0 6155.8 5951.0 6116.4 6159.9 6178.1 6219.1 5708.8 5710.7 5717.7 5736.6 5756.9 6235.3 6254.4 6254.7 6255.2 6256.8 5833.2 5931.6 5968.5 5987.2 5993.9 6034.8 6072.4 6082.0 6093.3 6101.0 5993.3 6024.9 6026.1 6057.2 6058.6 5992.5 6017.3 6043.7 6056.5 6067.7 4595.2 4611.1 4612.1 4620.2 4649.7 4038.3 4096.4 4101.4 4157.2 4180.6 5758.3 5797.5 5839.0 5846.3 5900.3 6159.4 6190.5 6210.2 6214.3 6215.1 5780.4 5875.4 5934.0 5956.6 5996.6 5050.8 5050.8 5081.9 5090.5 5109.5 6264.2 6278.7 6281.2 6298.8 6300.0 6010.7 6093.0 6093.0 6116.4 6121.9 6365.7 6367.1 6367.6 6382.0 6398.9 6085.5 6090.8 6096.8 6097.9 6104.8 5933.3 6137.1 6192.8 6197.7 6203.4 5962.6 6003.2 6009.3 6026.2 6036.2 5955.6 5996.7 6008.0 6015.6 6038.3 5635.2 5747.7 5806.4 5845.8 5878.2 6085.2 6107.7 6123.2 6132.7 6140.4 5857.0 5949.4 5959.6 5965.0 5968.6 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#1] ext.html Cycles:180 Average:57890.42 Median:43940.78 stddev:104965.64 (238.9%) stddev-sans-first:105172.14 03:51:19 INFO - PROCESS | 23784 | Values: 657.8 660.6 676.6 720.2 746.7 37325.0 40747.0 41438.4 41844.4 42046.0 46091.5 47099.0 47579.3 47768.5 47839.5 9078.0 9298.7 9317.3 9337.0 9354.6 8964.3 9093.6 9136.3 9197.6 9217.1 9116.6 9261.9 9266.2 9283.5 9310.0 9117.7 9158.9 9172.0 9181.6 9218.0 9061.3 9117.2 9170.5 9185.3 9224.2 43039.8 43662.8 43792.0 43957.0 44019.0 3885.5 3897.1 3931.5 3982.1 4069.6 32916.2 33295.3 33659.0 33894.5 34098.0 4472.9 4543.1 4559.9 4568.3 4577.8 344548.3 344704.0 344752.0 345760.0 348059.0 65617.7 66469.7 66635.3 66681.0 66730.3 62389.7 63428.4 63517.4 63572.7 63643.0 18888.2 19032.9 19058.8 19094.2 19149.0 14885.4 14910.3 14950.3 14991.8 15028.8 20487.9 20738.0 20830.4 21423.5 21595.0 7724.4 7737.6 7742.7 7780.1 7832.3 1097.8 1145.8 1157.4 1194.3 1214.9 32927.2 33287.0 33507.5 33977.8 34001.1 1179.7 1192.7 1218.7 1225.4 1227.3 17715.8 18024.3 18052.6 18134.7 18229.6 317031.0 321311.0 321933.0 407161.0 505173.0 58714.1 59553.4 59619.7 59781.0 60012.4 1509.1 1511.6 1514.6 1523.8 1614.0 30275.8 31233.1 31422.0 32033.4 32290.4 51545.5 52826.0 52964.0 52968.2 55735.2 454480.0 459577.0 459619.0 462554.0 463920.0 46831.3 47160.7 47820.0 47833.0 48133.0 53760.5 54174.5 55141.7 55850.7 56122.0 43689.8 44683.0 44917.1 45493.3 46233.8 38105.6 40109.6 43924.6 44154.8 46119.3 39204.8 39737.4 39831.4 40311.4 40976.4 33648.5 33739.7 34285.5 34305.8 34613.1 26558.2 26809.0 27324.0 27462.5 27800.9 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#2] jquery.html Cycles:180 Average:26396.58 Median:2140.44 stddev:64010.72 (2990.5%) stddev-sans-first:64160.57 03:51:19 INFO - PROCESS | 23784 | Values: 415.8 418.8 429.8 433.2 433.7 18690.0 18710.7 19330.6 20650.7 20769.3 18380.8 18491.4 19264.6 19293.9 19423.5 5222.9 5388.8 5433.7 5445.3 5457.5 5269.8 5399.5 5504.6 5513.2 5513.7 5503.0 5507.4 5517.4 5518.4 5520.3 5489.1 5615.9 5788.8 5808.1 5857.4 5593.1 5653.9 5694.8 5864.8 5909.4 13712.8 13921.1 14169.2 14315.7 14436.9 2445.8 2460.6 2505.6 2523.5 2650.5 10081.5 10623.4 10710.8 10734.9 10931.2 2043.6 2103.6 2122.6 2205.1 2206.3 87943.6 91082.5 91260.5 91846.5 91871.5 10896.9 11340.8 11873.9 12064.5 12189.3 15162.9 17130.1 17150.9 17221.2 17244.7 7998.5 8213.0 8270.0 8316.9 8437.8 7996.0 8007.7 8068.2 8165.4 8225.5 5057.2 5141.7 5188.3 5194.4 5230.0 2128.7 2152.2 2162.5 2175.3 2188.1 1003.8 1055.5 1056.1 1065.4 1082.3 19317.2 19487.6 19503.5 19593.8 19920.3 1131.5 1140.1 1145.0 1154.4 1204.1 11000.0 11020.8 11053.8 11058.2 11139.7 368696.0 368894.0 369663.0 372276.0 418431.0 99825.5 100601.5 103464.5 103573.0 106216.5 1126.4 1167.8 1176.8 1179.7 1180.2 17850.7 18033.8 18076.3 18253.0 18328.8 39965.6 40894.0 43318.4 43332.6 43834.0 53886.7 55098.0 56606.4 57295.1 57838.7 5767.8 8460.4 8535.5 9036.6 9070.8 12476.4 13517.1 13716.2 13821.0 14120.5 12403.4 12413.1 12496.9 12654.4 12809.7 11300.8 11637.8 11643.6 12341.0 12386.2 6366.6 10719.9 12391.5 12460.8 12674.9 9219.6 9269.0 9334.6 9340.3 9373.4 9487.8 12387.4 12496.4 12681.4 12724.5 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#3] mootools.html Cycles:180 Average:5858.98 Median:2685.11 stddev:3228.35 (120.2%) stddev-sans-first:3220.73 03:51:19 INFO - PROCESS | 23784 | Values: 1492.9 1573.7 1763.5 1869.2 1917.6 7861.0 8406.8 8507.7 8804.7 8859.9 8468.7 8482.4 8562.2 8569.0 8582.0 2436.4 2473.9 2483.3 2495.8 2500.3 2325.2 2424.4 2427.4 2451.9 2452.4 2433.7 2458.4 2506.2 2507.9 2515.6 2233.2 2243.4 2247.2 2295.1 2326.5 2385.7 2399.0 2399.8 2422.4 2446.4 8649.7 8699.4 8727.5 8734.7 8734.9 5398.2 5644.2 5647.2 5656.8 5657.3 3576.8 3599.6 3682.7 3705.1 3789.9 1142.8 1165.0 1176.7 1188.6 1195.7 12075.0 12081.5 12165.7 12166.4 12234.0 4887.7 4955.2 4959.3 4964.0 5077.1 10210.4 10306.7 10325.7 10404.7 10404.9 5561.5 5640.8 5672.7 5686.3 5692.8 4508.6 4910.2 5000.7 5053.0 5271.1 4219.5 4223.7 4309.2 4310.4 4333.3 1397.8 1402.5 1406.6 1408.3 1411.1 941.5 1058.1 1074.1 1080.0 1083.7 5963.6 6059.2 6062.6 6105.1 6237.0 473.0 482.6 514.8 519.1 522.8 4271.8 4290.2 4296.2 4330.2 4342.6 10409.6 10739.6 10814.9 10834.9 10953.5 10621.8 10674.5 10744.8 10803.0 10815.0 7841.7 7951.6 7962.6 7986.8 8000.1 5916.3 5983.6 6079.0 6104.8 6223.7 9594.4 10020.6 10041.7 10235.1 10239.7 10223.1 10362.2 10431.3 10460.9 10524.1 7577.8 7729.1 7774.6 7835.9 7876.2 8338.8 8421.0 8464.4 8498.0 8508.2 7405.4 7642.4 7661.2 7688.8 7690.3 7450.3 7531.4 7552.2 7611.0 7634.9 7327.6 7392.5 7408.5 7412.1 7433.0 5239.6 5324.6 5429.4 5429.5 5460.7 5099.3 5197.2 5244.9 5289.8 5308.1 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#4] prototype.html Cycles:180 Average:5212.22 Median:5880.76 stddev:1578.65 (26.8%) stddev-sans-first:1540.15 03:51:19 INFO - PROCESS | 23784 | Values: 340.6 342.5 347.6 347.8 353.0 5811.6 5853.3 5871.8 5878.2 5883.4 5682.1 5720.3 5728.2 5762.2 5766.3 4032.7 4304.2 4421.4 4482.3 4488.4 4410.5 4450.5 4461.2 4468.9 4483.6 4451.5 4504.1 4517.7 4518.0 4527.6 4426.0 4454.3 4460.2 4502.3 4506.6 3934.3 3938.6 3965.7 3966.1 3969.2 5482.4 5498.3 5514.9 5546.6 5550.7 5037.8 5040.8 5114.3 5126.3 5162.1 5923.0 5956.8 5985.5 5989.8 6027.2 4346.7 4387.4 4413.0 4423.5 4430.3 5893.7 6095.9 6227.4 6260.0 6284.5 4377.5 4396.5 4408.2 4409.6 4417.8 4450.3 4457.7 4477.9 4493.9 4496.9 4959.5 5074.7 5101.3 5106.0 5135.7 6051.0 6072.9 6083.8 6088.5 6126.8 1634.1 1635.4 1639.3 1644.0 1647.6 1045.6 1070.9 1077.9 1094.1 1112.1 6218.9 6266.5 6273.2 6275.9 6296.9 6628.6 6639.0 6645.5 6672.7 6682.6 5713.2 6050.5 6057.8 6067.5 6083.4 3622.8 3627.6 3628.1 3632.7 3634.2 6810.4 6959.2 7013.5 7018.4 7026.5 6863.9 6897.3 6915.5 6923.2 6942.9 6798.6 6930.5 7004.8 7075.3 7079.2 6623.3 6692.0 6779.5 6794.1 6797.7 5887.9 6406.8 6678.0 6678.7 6724.0 6191.7 6467.6 6473.0 6475.0 6508.7 4305.1 4310.2 4314.9 4320.8 4329.2 5998.3 6295.9 6337.0 6350.7 6356.2 6147.8 6180.7 6193.0 6201.6 6210.8 6013.3 6024.3 6135.7 6145.0 6175.5 5959.0 5969.9 5987.5 6002.4 6045.4 6168.6 6183.7 6195.7 6248.3 6265.7 5871.5 5896.2 6004.5 6027.4 6031.9 03:51:19 INFO - PROCESS | 23784 | 03:51:19 INFO - PROCESS | 23784 | [#5] yui.html Cycles:180 Average:15801.17 Median:4824.82 stddev:18410.76 (381.6%) stddev-sans-first:18428.15 03:51:19 INFO - PROCESS | 23784 | Values: 845.5 857.1 918.8 920.6 924.4 14495.9 14955.1 14973.5 14983.6 15034.4 12729.4 14688.6 14700.0 14728.4 14763.3 860.0 872.9 873.2 879.2 881.3 883.5 883.7 885.0 889.2 899.9 939.5 942.4 946.7 951.2 951.5 937.3 939.8 940.6 944.2 945.6 693.1 694.2 695.8 697.1 699.2 14856.8 15060.7 15138.1 15145.7 15185.8 14972.2 15053.2 15075.7 15219.3 15250.7 11560.0 11603.4 11638.4 11768.9 11776.0 4001.0 4021.1 4092.3 4114.9 4123.1 53149.5 53283.7 54003.9 54270.0 54802.7 12005.6 12017.3 12059.3 12076.6 12086.7 20521.2 20540.7 20566.3 20724.6 20873.6 8780.7 8783.9 8879.6 8899.7 8951.1 4809.9 4894.2 4952.0 4952.7 4977.0 3502.5 3608.2 3608.6 3612.8 3615.8 605.7 678.2 682.7 683.2 684.0 652.2 779.4 783.3 798.8 812.2 9397.0 9984.3 10246.8 10381.5 10599.4 760.6 792.0 792.2 796.3 827.9 4782.6 4839.8 4905.2 4948.0 4948.7 64112.4 66331.7 66455.0 66541.7 66595.0 60893.0 62811.0 63595.4 63621.0 64133.4 54339.2 55189.4 55233.7 55606.4 55961.0 9278.6 9332.3 9533.0 9587.3 9710.5 36735.6 36910.6 37397.8 37595.6 38468.8 46932.5 48953.5 49436.8 49497.8 50028.7 12129.5 12228.4 12321.7 12442.9 12721.1 12957.4 13486.0 13637.5 13677.9 13805.9 12222.0 12264.0 12498.6 12626.3 12787.5 11981.0 12202.1 12387.5 12839.0 13026.7 12383.8 12522.8 12641.3 13253.7 13261.0 10983.2 11008.1 11129.8 11417.4 11751.7 11483.2 12176.6 12363.9 12400.4 12497.6 03:51:19 INFO - PROCESS | 23784 | -------- Summary: end -------- 03:51:19 INFO - PROCESS | 23784 | 03:51:20 INFO - TEST-INFO | 23784: exit 0 03:51:20 INFO - TEST-OK | dromaeo_css | took 1109516ms 03:51:20 INFO - TEST-START | kraken 03:51:20 INFO - operating with platform_type : linux_ 03:51:20 INFO - Initialising browser for kraken test... 03:51:20 INFO - TEST-INFO | started process 24024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp19Vuke/profile http://localhost:40856/getInfo.html) 03:51:23 INFO - PROCESS | 24024 | 03:51:23 INFO - PROCESS | 24024 | (process:24097): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:24 INFO - PROCESS | 24024 | __metrics Screen width/height:1600/1200 03:51:24 INFO - PROCESS | 24024 | colorDepth:24 03:51:24 INFO - PROCESS | 24024 | Browser inner width/height: 1024/697 03:51:24 INFO - PROCESS | 24024 | __metrics 03:51:25 ERROR - PROCESS | 24024 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:51:26 INFO - TEST-INFO | 24024: exit 0 03:51:26 INFO - Browser initialized. 03:51:26 INFO - Running cycle 1/1 for kraken test... 03:51:26 INFO - TEST-INFO | started process 24148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp19Vuke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:28 INFO - PROCESS | 24148 | 03:51:28 INFO - PROCESS | 24148 | (process:24219): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:51:38 INFO - PROCESS | 24148 | RSS: Main: 152625152 03:51:38 INFO - PROCESS | 24148 | 03:51:40 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40856/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:41 INFO - PROCESS | 24148 | RSS: Main: 156852224 03:51:41 INFO - PROCESS | 24148 | 03:51:44 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40856/tests/kraken/driver.html?testName=audio-dft) 03:51:44 INFO - PROCESS | 24148 | RSS: Main: 157036544 03:51:44 INFO - PROCESS | 24148 | 03:51:47 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40856/tests/kraken/driver.html?testName=audio-fft) 03:51:48 INFO - PROCESS | 24148 | RSS: Main: 157282304 03:51:48 INFO - PROCESS | 24148 | 03:51:50 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40856/tests/kraken/driver.html?testName=audio-oscillator) 03:51:50 INFO - PROCESS | 24148 | RSS: Main: 157319168 03:51:50 INFO - PROCESS | 24148 | 03:51:53 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:53 INFO - PROCESS | 24148 | RSS: Main: 157302784 03:51:53 INFO - PROCESS | 24148 | 03:51:56 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40856/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:57 INFO - PROCESS | 24148 | RSS: Main: 157847552 03:51:57 INFO - PROCESS | 24148 | 03:52:00 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40856/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:01 INFO - PROCESS | 24148 | RSS: Main: 157560832 03:52:01 INFO - PROCESS | 24148 | 03:52:04 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40856/tests/kraken/driver.html?testName=json-parse-financial) 03:52:04 INFO - PROCESS | 24148 | RSS: Main: 157650944 03:52:04 INFO - PROCESS | 24148 | 03:52:06 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:06 INFO - PROCESS | 24148 | RSS: Main: 157650944 03:52:06 INFO - PROCESS | 24148 | 03:52:08 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:09 INFO - PROCESS | 24148 | RSS: Main: 157454336 03:52:09 INFO - PROCESS | 24148 | 03:52:11 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:11 INFO - PROCESS | 24148 | RSS: Main: 157478912 03:52:11 INFO - PROCESS | 24148 | 03:52:14 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:15 INFO - PROCESS | 24148 | RSS: Main: 157818880 03:52:15 INFO - PROCESS | 24148 | 03:52:17 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:18 INFO - PROCESS | 24148 | RSS: Main: 158232576 03:52:18 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | Cycle 1(1): loaded http://localhost:40856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40856/tests/kraken/driver.html?testName=ai-astar) 03:52:20 INFO - PROCESS | 24148 | RSS: Main: 159461376 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | __start_tp_report 03:52:20 INFO - PROCESS | 24148 | _x_x_mozilla_page_load 03:52:20 INFO - PROCESS | 24148 | _x_x_mozilla_page_load_details 03:52:20 INFO - PROCESS | 24148 | |i|pagename|runs| 03:52:20 INFO - PROCESS | 24148 | |0;ai-astar;112;106;112;111;112;122;110;113;111;112 03:52:20 INFO - PROCESS | 24148 | |1;audio-beat-detection;158;125;154;171;130;163;156;128;186;127 03:52:20 INFO - PROCESS | 24148 | |2;audio-dft;162;163;162;161;163;163;163;162;166;162 03:52:20 INFO - PROCESS | 24148 | |3;audio-fft;76;76;74;174;75;77;75;77;169;77 03:52:20 INFO - PROCESS | 24148 | |4;audio-oscillator;92;92;150;92;92;93;147;92;92;149 03:52:20 INFO - PROCESS | 24148 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;117;118;118 03:52:20 INFO - PROCESS | 24148 | |6;imaging-darkroom;146;153;146;147;146;147;145;147;146;146 03:52:20 INFO - PROCESS | 24148 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;96;96 03:52:20 INFO - PROCESS | 24148 | |8;json-parse-financial;56;55;56;55;56;56;56;71;55;52 03:52:20 INFO - PROCESS | 24148 | |9;json-stringify-tinderbox;57;57;56;57;56;55;57;68;58;57 03:52:20 INFO - PROCESS | 24148 | |10;stanford-crypto-aes;80;80;75;72;81;74;74;74;78;75 03:52:20 INFO - PROCESS | 24148 | |11;stanford-crypto-ccm;121;133;121;126;121;118;122;126;155;124 03:52:20 INFO - PROCESS | 24148 | |12;stanford-crypto-pbkdf2;159;164;164;160;166;161;158;168;160;166 03:52:20 INFO - PROCESS | 24148 | |13;stanford-crypto-sha256-iterative;66;66;66;69;67;65;66;65;65;74 03:52:20 INFO - PROCESS | 24148 | __end_tp_report 03:52:20 INFO - PROCESS | 24148 | __start_cc_report 03:52:20 INFO - PROCESS | 24148 | _x_x_mozilla_cycle_collect,847 03:52:20 INFO - PROCESS | 24148 | __end_cc_report 03:52:20 INFO - PROCESS | 24148 | __startTimestamp1462013540349__endTimestamp 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | ------- Summary: start ------- 03:52:20 INFO - PROCESS | 24148 | Number of tests: 14 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.23 03:52:20 INFO - PROCESS | 24148 | Values: 112.0 106.0 112.0 111.0 112.0 122.0 110.0 113.0 111.0 112.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:157.00 stddev:21.24 (13.5%) stddev-sans-first:22.32 03:52:20 INFO - PROCESS | 24148 | Values: 158.0 125.0 154.0 171.0 130.0 163.0 156.0 128.0 186.0 127.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 03:52:20 INFO - PROCESS | 24148 | Values: 162.0 163.0 162.0 161.0 163.0 163.0 163.0 162.0 166.0 162.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.35 (53.1%) stddev-sans-first:42.21 03:52:20 INFO - PROCESS | 24148 | Values: 76.0 76.0 74.0 174.0 75.0 77.0 75.0 77.0 169.0 77.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.31 (29.7%) stddev-sans-first:28.26 03:52:20 INFO - PROCESS | 24148 | Values: 92.0 92.0 150.0 92.0 92.0 93.0 147.0 92.0 92.0 149.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:52:20 INFO - PROCESS | 24148 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.50 stddev:2.23 (1.5%) stddev-sans-first:2.35 03:52:20 INFO - PROCESS | 24148 | Values: 146.0 153.0 146.0 147.0 146.0 147.0 145.0 147.0 146.0 146.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:52:20 INFO - PROCESS | 24148 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 96.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:5.14 (9.2%) stddev-sans-first:5.44 03:52:20 INFO - PROCESS | 24148 | Values: 56.0 55.0 56.0 55.0 56.0 56.0 56.0 71.0 55.0 52.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:57.00 stddev:3.68 (6.4%) stddev-sans-first:3.89 03:52:20 INFO - PROCESS | 24148 | Values: 57.0 57.0 56.0 57.0 56.0 55.0 57.0 68.0 58.0 57.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.50 stddev:3.16 (4.1%) stddev-sans-first:3.06 03:52:20 INFO - PROCESS | 24148 | Values: 80.0 80.0 75.0 72.0 81.0 74.0 74.0 74.0 78.0 75.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:10.77 (8.6%) stddev-sans-first:11.22 03:52:20 INFO - PROCESS | 24148 | Values: 121.0 133.0 121.0 126.0 121.0 118.0 122.0 126.0 155.0 124.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:164.00 stddev:3.44 (2.1%) stddev-sans-first:3.39 03:52:20 INFO - PROCESS | 24148 | Values: 159.0 164.0 164.0 160.0 166.0 161.0 158.0 168.0 160.0 166.0 03:52:20 INFO - PROCESS | 24148 | 03:52:20 INFO - PROCESS | 24148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:2.77 (4.2%) stddev-sans-first:2.92 03:52:20 INFO - PROCESS | 24148 | Values: 66.0 66.0 66.0 69.0 67.0 65.0 66.0 65.0 65.0 74.0 03:52:20 INFO - PROCESS | 24148 | -------- Summary: end -------- 03:52:20 INFO - PROCESS | 24148 | 03:52:21 INFO - TEST-INFO | 24148: exit 0 03:52:21 INFO - TEST-OK | kraken | took 61113ms 03:52:21 INFO - SUITE-END | took 1170s 03:52:21 INFO - Completed test suite (00:19:30) 03:52:21 INFO - javascript benchmark 03:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.234736010718, 3398.0, 3427.7943323400614, 3461.4980827779955, 3466.012186526839, 5768.134779783029, 5774.469765512143, 5785.334686511042, 5797.217375654285, 5849.151872978416, 5704.828855134342, 5790.913136302948, 5797.797077102302, 5811.535077193825, 5822.767089316433, 5192.376914770223, 5227.294315267447, 5276.762545685453, 5313.521783039526, 5349.839504814861, 5109.923351149717, 5207.4792520747815, 5357.973210133963, 5368.46315368462, 5382.730863456831, 5183.585313174955, 5208.5051920067535, 5219.530242278194, 5233.712145831978, 5242.344706911636, 5236.738163091849, 5268.6575372600655, 5268.683878967255, 5283.498067683564, 5313.468653134656, 4985.975070124662, 5072.213806859942, 5127.077126117298, 5151.665141765773, 5158.92261616076, 5534.308211473566, 5539.307586551681, 5552.77788888444, 5580.637258578179, 5625.240592520039, 6075.2405949256345, 6102.450779429828, 6105.8168254952425, 6113.0, 6155.815325540196, 5951.0, 6116.388361163892, 6159.938400616026, 6178.10417489466, 6219.129321894939, 5708.828735137952, 5710.71446427677, 5717.742701578397, 5736.569757268222, 5756.942430575725, 6235.282942461675, 6254.437100660963, 6254.749810007549, 6255.218097737783, 6256.781012664626, 5833.183354330397, 5931.6441013539325, 5968.522518198533, 5987.191729116601, 5993.880122397615, 6034.788782392595, 6072.423119803611, 6081.969590152021, 6093.26880774301, 6101.0, 5993.250843644544, 6024.909626355608, 6026.126211699279, 6057.212562366953, 6058.606190597597, 5992.520598352121, 6017.2779266488305, 6043.667598282049, 6056.515478761777, 6067.7269522871575, 4595.241785105421, 4611.146937816515, 4612.146752850734, 4620.214563524209, 4649.697769644962, 4038.3134867072667, 4096.365063415115, 4101.405296232089, 4157.168566286755, 4180.623743863067, 5758.2514273144225, 5797.4782269595935, 5839.0, 5846.327672317653, 5900.262467191601, 6159.443701630747, 6190.535709821781, 6210.192674952227, 6214.347493513206, 6215.098810672427, 5780.364159942403, 5875.353711091777, 5933.970330148408, 5956.583039187302, 5996.580239383201, 5050.823221187241, 5050.84847454577, 5081.8729531762, 5090.49095090488, 5109.514596113363, 6264.248290205204, 6278.748850046039, 6281.214848143982, 6298.811035668938, 6299.968500157562, 6010.699465026819, 6092.969535152296, 6093.0, 6116.396640261158, 6121.938780612315, 6365.7135428904885, 6367.076773867856, 6367.586106903036, 6381.968090159519, 6398.936010639834, 6085.513158947185, 6090.786822461193, 6096.847578810565, 6097.939020609737, 6104.786332478342, 5933.317668468181, 6137.140800287874, 6192.752289908353, 6197.721102550487, 6203.379662033761, 5962.642241465526, 6003.159557662018, 6009.308929473166, 6026.216591843032, 6036.245469316335, 5955.642661440327, 5996.67018313997, 6008.0, 6015.639061656315, 6038.305594856648, 5635.182898479616, 5747.74135163927, 5806.44838740319, 5845.795397161079, 5878.177055212188, 6085.208922840003, 6107.725152368243, 6123.234595675541, 6132.693365331805, 6140.355262697352, 5857.0043092673495, 5949.434803693643, 5959.582829201914, 5965.0, 5968.552358573212], "value": 5641.340074340497, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.7927952694904, 660.6267458885729, 676.5737585321249, 720.1933834105803, 746.7125156814626, 37325.0, 40747.0, 41438.378424323586, 41844.372334415006, 42046.0, 46091.53908460923, 47099.0, 47579.28631070536, 47768.52231477684, 47839.52160478394, 9078.046805085487, 9298.72103836886, 9317.301202409812, 9336.953315233415, 9354.625814967394, 8964.327675424336, 9093.590788414538, 9136.314776391764, 9197.586108625095, 9217.124373184537, 9116.635334586641, 9261.907380926206, 9266.212371948392, 9283.535823208846, 9310.0, 9117.68088116916, 9158.862617060682, 9171.99108098112, 9181.632734690604, 9218.0, 9061.275097992146, 9117.17945384912, 9170.541472926327, 9185.265178785681, 9224.169824715807, 43039.784801075795, 43662.781686091366, 43792.0, 43957.0, 44019.0, 3885.5337359516757, 3897.1424597793844, 3931.5085614298214, 3982.1239327348226, 4069.552349241581, 32916.177095572566, 33295.33409331824, 33659.0, 33894.49158262628, 34098.0, 4472.910541789146, 4543.091381723635, 4559.908801823978, 4568.337591049312, 4577.793999270041, 344548.2772586146, 344704.0, 344752.0, 345760.0, 348059.0, 65617.6719116411, 66469.66765166144, 66635.33364666291, 66681.0, 66730.33269667241, 62389.68805155945, 63428.36571634225, 63517.364826352066, 63572.68213658902, 63643.0, 18888.24447022131, 19032.904835476013, 19058.809411905702, 19094.2362305509, 19149.0, 14885.404583816742, 14910.25448727581, 14950.252487375588, 14991.775123373158, 15028.774568381483, 20487.8975605121, 20738.0, 20830.37508874736, 21423.46441338979, 21595.0, 7724.382049436032, 7737.645911965384, 7742.6902923883545, 7780.105287891852, 7832.295093441618, 1097.7694684116425, 1145.7536629624503, 1157.4444266752007, 1194.2595590733627, 1214.9149559530924, 32927.176820579196, 33287.0, 33507.49738753921, 33977.83011084978, 34001.14997125092, 1179.6755892129734, 1192.7077865922904, 1218.7440637466232, 1225.3628113381171, 1227.2759072147476, 17715.822841771416, 18024.279028838962, 18052.63894722098, 18134.727979080326, 18229.635407292044, 317031.0, 321311.0, 321933.0, 407161.0, 505173.0, 58714.11928821071, 59553.40446595565, 59619.70190149022, 59781.0, 60012.39987600155, 1509.124707669549, 1511.5843143135726, 1514.606202387365, 1523.8476152384894, 1614.039646410384, 30275.848620756755, 31233.06300810979, 31422.0, 32033.359332813678, 32290.35419291648, 51545.48454515407, 52826.0, 52964.0, 52968.20547691711, 55735.16397254125, 454480.0, 459577.0, 459619.0, 462554.0, 463920.0, 46831.29753053775, 47160.66620125606, 47820.0, 47833.0, 48133.0, 53760.46239537711, 54174.45825541694, 55141.72429137828, 55850.72074639601, 56122.0, 43689.78155109204, 44683.0, 44917.101657966006, 45493.31760023536, 46233.76883115563, 38105.61894381021, 40109.59890401176, 43924.56075439205, 44154.77922610495, 46119.3082103762, 39204.803975979936, 39737.40393894152, 39831.402528962666, 40311.39532907067, 40976.38535422031, 33648.49527257044, 33739.662603373654, 34285.48571771475, 34305.79929702448, 34613.13467163341, 26558.203253902415, 26809.0, 27324.0, 27462.45075098447, 27800.860995694893], "value": 21287.117210312168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.7775590059319, 418.8157210827236, 429.83666206841394, 433.17047853360816, 433.6920786241768, 18690.0, 18710.71933920992, 19330.613387732235, 20650.690239646417, 20769.27307544236, 18380.81619183808, 18491.445256642288, 19264.614707705874, 19293.903530482363, 19423.51441213967, 5222.8694282642955, 5388.78444862205, 5433.673979561219, 5445.264889239961, 5457.481539253785, 5269.76286067126, 5399.514043736063, 5504.64219825712, 5513.2005859150395, 5513.696746678931, 5503.0, 5507.421720719327, 5517.393086760453, 5518.365387980393, 5520.337559492847, 5489.1217405215175, 5615.887682246353, 5788.7684492620665, 5808.128780682931, 5857.355690874022, 5593.105103183511, 5653.943460565424, 5694.77220911163, 5864.76540938362, 5909.379515150933, 13712.794308085387, 13921.095128816594, 14169.220692861889, 14315.713685726332, 14436.855631443761, 2445.8287919845616, 2460.5940019896875, 2505.649209110726, 2523.5331463679277, 2650.4566563854364, 10081.546330415149, 10623.36259824413, 10710.785784284348, 10734.892651073545, 10931.234813563055, 2043.632146213681, 2103.63186442372, 2122.628540005493, 2205.128974055255, 2206.30501392061, 87943.56028219817, 91082.5445872773, 91260.54369728176, 91846.5407672964, 91871.54064229703, 10896.891031089746, 11340.773184536429, 11873.940630296793, 12064.457099430547, 12189.329586872807, 15162.924185379003, 17130.057846818294, 17150.914245428943, 17221.225044873012, 17244.655106897793, 7998.480098793676, 8213.0, 8269.95865020683, 8316.916830831615, 8437.831243375098, 7995.960020199978, 8007.678733008988, 8068.193180681885, 8165.387595930329, 8225.506469611722, 5057.241413787961, 5141.691498510101, 5188.325517682677, 5194.3766747990485, 5230.006298803215, 2128.70198172256, 2152.171414005619, 2162.470194802252, 2175.282156888223, 2188.0591345721173, 1003.8042581696645, 1055.5091882274778, 1056.0864851903202, 1065.3980501016902, 1082.3397727386289, 19317.22731090769, 19487.610247794964, 19503.512412189808, 19593.804061959483, 19920.3027894023, 1131.536070211226, 1140.0594509529672, 1144.959926402572, 1154.440096553171, 1204.1450570095155, 11000.009999100119, 11020.779584408427, 11053.834192486958, 11058.22592418539, 11139.665810025712, 368696.0, 368894.0, 369663.0, 372276.0, 418431.0, 99825.50087249518, 100601.49699251457, 103464.48267758764, 103573.0, 106216.46891765491, 1126.3748619516084, 1167.8131498960126, 1176.7822952753768, 1179.722765150189, 1180.2151569206553, 17850.732239016164, 18033.819661803213, 18076.276948921895, 18253.0, 18328.81671183271, 39965.60034399735, 40894.0, 43318.35022474602, 43332.566674332855, 43834.0, 53886.73056634849, 55098.0, 56606.43393566012, 57295.14057289228, 57838.7108064457, 5767.826965191051, 8460.365472589458, 8535.487870727777, 9036.59335329925, 9070.773230669287, 12476.376181191086, 13517.053806233469, 13716.24560649134, 13821.0, 14120.50578229757, 12403.379831008593, 12413.069019823368, 12496.93751531273, 12654.43055062506, 12809.679758006125, 11300.830487542858, 11637.76724465489, 11643.59247426336, 12341.01271898228, 12386.194897331645, 6366.586171898812, 10719.946400267949, 12391.504339826306, 12460.813087803508, 12674.873251267738, 9219.631214751334, 9269.0, 9334.579943902405, 9340.252779777466, 9373.437593744397, 9487.810243795224, 12387.442565084413, 12496.437660305126, 12681.365931703562, 12724.491020359083], "value": 9361.234509086662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.9402823887042, 1573.6852629474104, 1763.5326638440808, 1869.2055876252598, 1917.6452356314092, 7861.0, 8406.831863362737, 8507.659693612248, 8804.691835785748, 8859.867101993475, 8468.745937621881, 8482.448640838342, 8562.229399354072, 8569.0, 8581.95709021454, 2436.390902274436, 2473.88867500962, 2483.3046746910895, 2495.7878580320694, 2500.2624225853415, 2325.162941341116, 2424.381782645423, 2427.3688840901405, 2451.8528888266674, 2452.448199155194, 2433.6714543536573, 2458.4345600511892, 2506.1604362538574, 2507.862067586282, 2515.5723527000364, 2233.218373569254, 2243.4279258789065, 2247.191011235962, 2295.127851416468, 2326.5114325991563, 2385.7256415512265, 2398.988005059981, 2399.7600239976036, 2422.358075110097, 2446.449548851512, 8649.65401383944, 8699.434536755154, 8727.519986400745, 8734.73795786121, 8734.912650873473, 5398.24424580559, 5644.238027866227, 5647.209390685307, 5656.773729050833, 5657.321121465409, 3576.8211589420685, 3599.6040435552068, 3682.6685598296012, 3705.055210921225, 3789.905252368713, 1142.7885841119419, 1165.044663376032, 1176.688177632928, 1188.5661733467223, 1195.7429152732118, 12075.033997280196, 12081.456334464881, 12165.695857603541, 12166.391680416033, 12234.0, 4887.65786394956, 4955.231939049453, 4959.305697202394, 4963.975180124148, 5077.086124497552, 10210.387376757419, 10306.690799276033, 10325.690229292983, 10404.68785936423, 10404.895951040393, 5561.4716601922755, 5640.802571910045, 5672.716364181857, 5686.260786097863, 5692.772289108472, 4508.639308855284, 4910.21436570147, 5000.724960127228, 5053.0399224147295, 5271.1302635064785, 4219.535851056381, 4223.66210703143, 4309.181255561496, 4310.353446982977, 4333.306670932636, 1397.832809603992, 1402.502111750314, 1406.585057408067, 1408.295852073963, 1411.0968979852903, 941.4868896451451, 1058.074185088048, 1074.1245884604023, 1079.96220132295, 1083.7019819549687, 5963.5527335450015, 6059.242594675666, 6062.605930614496, 6105.084237364431, 6237.0020796673225, 473.03028790978357, 482.55604843544023, 514.765781569385, 519.0708631549484, 522.7804322184692, 4271.786410679516, 4290.249206388869, 4296.2481565725875, 4330.242207613655, 4342.630876375543, 10409.5836166554, 10739.624113156002, 10814.94592527048, 10834.891651083388, 10953.452327383759, 10621.787564248672, 10674.466276686135, 10744.785104297871, 10803.0, 10815.0, 7841.725539606086, 7951.602419878983, 7962.56205908669, 7986.840263194704, 8000.119986801564, 5916.290045194604, 5983.58114931968, 6079.045488441461, 6104.847378815565, 6223.719932603134, 9594.42433453995, 10020.599176032876, 10041.698749037541, 10235.078842904175, 10239.7440063999, 10223.079922806983, 10362.171026318027, 10431.269811113149, 10460.947695261779, 10524.105451036748, 7577.772666820004, 7729.111152217342, 7774.572398518136, 7835.882461762964, 7876.173001834954, 8338.791530211793, 8420.957895210484, 8464.407491475538, 8497.957510212409, 8508.191721786421, 7405.407567394704, 7642.388608911163, 7661.195574464601, 7688.807779805549, 7690.346320562591, 7450.254974502506, 7531.435142364235, 7552.244775522404, 7610.961945190239, 7634.885476717965, 7327.63361831917, 7392.519486233377, 7408.518446301189, 7412.073490813648, 7432.962835186006, 5239.580833533232, 5324.574034077187, 5429.375621803543, 5429.538489228302, 5460.672359658433, 5099.260607212008, 5197.194434862602, 5244.947550524446, 5289.814856480005, 5308.124159513637], "value": 4685.829062860229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5776836722464, 342.5290225939332, 347.58984398409865, 347.8017530007895, 352.9841157147929, 5811.5641326900495, 5853.326867410249, 5871.76512939483, 5878.177055212263, 5883.352831188571, 5682.147677848315, 5720.342160651527, 5728.198052272685, 5762.193292938992, 5766.308043034842, 4032.717709760318, 4304.182205380983, 4421.447319085114, 4482.327650852382, 4488.371627972087, 4410.514843367227, 4450.488193857699, 4461.196984542781, 4468.932966005513, 4483.5964763171305, 4451.5103338632725, 4504.121696269229, 4517.728936263835, 4517.954820451802, 4527.637788976874, 4425.955740442602, 4454.28731402974, 4460.241758900995, 4502.2571275739465, 4506.594406503414, 3934.252492026506, 3938.6455219030427, 3965.6827453803626, 3966.107625784204, 3969.206158768258, 5482.396936337, 5498.285222921035, 5514.862128446781, 5546.556275497991, 5550.69471179085, 5037.848864534069, 5040.798368065273, 5114.335136432277, 5126.282320475137, 5162.148245539482, 5922.97038514809, 5956.821295361146, 5985.461308482258, 5989.8203053908455, 6027.246594175728, 4346.673999450022, 4387.354741971761, 4412.977935110336, 4423.4912985006495, 4430.29115341547, 5893.7053147342895, 6095.878082438371, 6227.3772622737815, 6260.0, 6284.465820405271, 4377.4528183977, 4396.516383197845, 4408.206522825923, 4409.647228221735, 4417.823287068545, 4450.332450132441, 4457.665675074382, 4477.910441791211, 4493.932591011137, 4496.865094047183, 4959.479254678279, 5074.695518268915, 5101.2603172539775, 5105.974470127626, 5135.666181698178, 6050.969745151334, 6072.878542429126, 6083.7870674526175, 6088.459501853292, 6126.78556250538, 1634.133909028193, 1635.386729976259, 1639.319682331819, 1643.9753403698953, 1647.5881029742563, 1045.6026709850207, 1070.9303895246785, 1077.8975997280245, 1094.1465656787718, 1112.1047556716758, 6218.875622487525, 6266.530010249249, 6273.153124328157, 6275.874482510324, 6296.937030629727, 6628.635425051669, 6638.96680516604, 6645.501587380966, 6672.699728512229, 6682.565633233921, 5713.171590119409, 6050.48570871472, 6057.848553786191, 6067.453929146398, 6083.422074902877, 3622.836972336251, 3627.619099994515, 3628.1473853644375, 3632.7457078004813, 3634.23681026982, 6810.353016463428, 6959.22468495403, 7013.544119632207, 7018.438524917994, 7026.543274687129, 6863.862722745617, 6897.3447522485285, 6915.51591388598, 6923.2038315593345, 6942.93057069433, 6798.592084474947, 6930.480213983971, 7004.789856304319, 7075.257098004636, 7079.221285658574, 6623.3376662333385, 6691.966540167268, 6779.457643388616, 6794.116764820542, 6797.694103765243, 5887.911681324869, 6406.807795765948, 6677.959834300178, 6678.666066696743, 6724.0, 6191.721372538336, 6467.579607325509, 6472.967635161794, 6474.967625162032, 6508.739650413931, 4305.146893530336, 4310.2457070012, 4314.878131685847, 4320.805563749702, 4329.177456283422, 5998.3401825798255, 6295.9370406297185, 6337.04944258365, 6350.682465876595, 6356.237251529846, 6147.754089836357, 6180.721867515883, 6193.040078787795, 6201.627902325875, 6210.844728881814, 6013.294017692144, 6024.277086749618, 6135.662538560422, 6145.0028740660355, 6175.505959523317, 5958.9869722148205, 5969.940300597113, 5987.520998320037, 6002.429769171922, 6045.395460453919, 6168.568200226121, 6183.691724927143, 6195.721192546256, 6248.281447633399, 6265.749370025148, 5871.5027667944405, 5896.204012458435, 6004.459598636144, 6027.427394397525, 6031.879362412815], "value": 4710.970256014577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.5476320168711, 857.0829212742366, 918.8254231695973, 920.558132096594, 924.440713368412, 14495.927520362397, 14955.10269383835, 14973.47592834251, 14983.625409364771, 15034.398624055038, 12729.363531823417, 14688.559343219693, 14700.044497107681, 14728.410863565472, 14763.261836908165, 860.0453496618763, 872.9301655867547, 873.1835733589114, 879.1955360844819, 881.2597418168737, 883.5052370672412, 883.6553744039829, 885.0308911741632, 889.204162274767, 899.9235065019482, 939.4879790514186, 942.4015749998731, 946.7443790176649, 951.210495288912, 951.5147274889787, 937.292344280071, 939.7556635274809, 940.5720397219249, 944.1785646487531, 945.5886689290112, 693.1370443797454, 694.2155364438203, 695.8260434891278, 697.0554898113035, 699.1959246866094, 14856.777148342784, 15060.698786024328, 15138.091714497166, 15145.697086058328, 15185.848141518554, 14972.17653029083, 15053.172075535842, 15075.698486030327, 15219.315130819139, 15250.694986100327, 11560.0, 11603.4198290086, 11638.359890206035, 11768.882311176863, 11775.999040081604, 4000.959990400117, 4021.1008261172315, 4092.283850326181, 4114.897127571805, 4123.113530590907, 53149.468505314835, 53283.73358133184, 54003.919921601744, 54270.0, 54802.72598637021, 12005.579804706793, 12017.33904635236, 12059.336736479578, 12076.562655767051, 12086.697832554257, 20521.17915283372, 20540.691889621667, 20566.280180193622, 20724.58550828975, 20873.582528349347, 8780.692675756318, 8783.912160878437, 8879.556022198864, 8899.73300800977, 8951.060138685345, 4809.879753006203, 4894.216925291937, 4952.034353301072, 4952.666416885226, 4977.0, 3502.4571191465366, 3608.2422691235133, 3608.566971963381, 3612.8012959287494, 3615.8192090395373, 605.6699098991061, 678.1997243252911, 682.7337338438014, 683.2313647146959, 683.9931600684029, 652.1652285075112, 779.3842864137268, 783.2637320918318, 798.7843282313859, 812.1959260332228, 9397.0, 9984.301098923152, 10246.795064098676, 10381.532831022621, 10599.364038157735, 760.5512747478904, 792.0455850699893, 792.2473650032492, 796.3231253434534, 827.8882350882674, 4782.593479554277, 4839.758012099381, 4905.2151655734915, 4948.0, 4948.727819969936, 64112.35887641157, 66331.66834165798, 66455.0, 66541.66729166324, 66595.0, 60893.0, 62811.0, 63595.36404635895, 63621.0, 64133.358666413675, 54339.18491222714, 55189.44810551843, 55233.72383138139, 55606.443935560936, 55961.0, 9278.62885484573, 9332.30007749435, 9532.95233523828, 9587.328886977844, 9710.514474276399, 36735.63264367322, 36910.63089369072, 37397.81301093477, 37595.62404375921, 38468.807655961544, 46932.53067469282, 48953.5104648949, 49436.75281623569, 49497.75251123722, 50028.749856250484, 12129.454174562343, 12228.388580571114, 12321.691957701129, 12442.937785311016, 12721.109522333718, 12957.41691623898, 13486.0, 13637.522686705917, 13677.931610341884, 13805.930970345486, 12222.022238220743, 12264.0, 12498.562550310695, 12626.305553194663, 12787.488500459878, 11981.041516678819, 12202.084843636585, 12387.504499820267, 12839.0, 13026.674333141747, 12383.75232495327, 12522.812157817458, 12641.304728240035, 13253.668658283234, 13261.0, 10983.176261780558, 11008.119350451785, 11129.777404452028, 11417.429128543707, 11751.706207344885, 11483.196176267582, 12176.634700958986, 12363.93818030904, 12400.379981001095, 12497.56258530947], "value": 7209.882042270326, "unit": "score"}], "name": "dromaeo_css", "value": 7506.7132832332745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 111.0, 112.0, 122.0, 110.0, 113.0, 111.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 154.0, 171.0, 130.0, 163.0, 156.0, 128.0, 186.0, 127.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 163.0, 163.0, 162.0, 166.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 174.0, 75.0, 77.0, 75.0, 77.0, 169.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 92.0, 92.0, 93.0, 147.0, 92.0, 92.0, 149.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 153.0, 146.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 71.0, 55.0, 52.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 56.0, 55.0, 57.0, 68.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 75.0, 72.0, 81.0, 74.0, 74.0, 74.0, 78.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 133.0, 121.0, 126.0, 121.0, 118.0, 122.0, 126.0, 155.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 164.0, 160.0, 166.0, 161.0, 158.0, 168.0, 160.0, 166.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 69.0, 67.0, 65.0, 66.0, 65.0, 65.0, 74.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1535.3, "alertThreshold": 2.0}]} 03:52:21 INFO - Return code: 0 03:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:21 ERROR - # TBPL SUCCESS # 03:52:21 INFO - Running post-action listener: _resource_record_post_action 03:52:21 INFO - Running post-run listener: _resource_record_post_run 03:52:22 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 498016256; Read time: 164; Write time: 457236 03:52:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248913920; Read time: 0; Write time: 292324 03:52:22 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249102336; Read time: 164; Write time: 164912 03:52:22 INFO - Running post-run listener: _upload_blobber_files 03:52:22 INFO - Blob upload gear active. 03:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:22 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 03:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:52:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:23 INFO - (blobuploader) - INFO - Done attempting. 03:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:24 INFO - (blobuploader) - INFO - Done attempting. 03:52:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:24 INFO - Return code: 0 03:52:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48da62fee593be07e2732c15f94023dacb72e59fd768b029032e81f8633cb427d8ace774f6603435b4c8b52e409fbec69be6f38ff5420587075163caceabe3e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e1c41d256bc9f9c03adbd8ce5e61f285ce48506018a5b8cc772d66ef199160c577416f9bd8f7d3359cbaa261df58de9fed545cdc128be5af4c5cfcfc3a331c"} 03:52:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:24 INFO - Contents: 03:52:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48da62fee593be07e2732c15f94023dacb72e59fd768b029032e81f8633cb427d8ace774f6603435b4c8b52e409fbec69be6f38ff5420587075163caceabe3e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e1c41d256bc9f9c03adbd8ce5e61f285ce48506018a5b8cc772d66ef199160c577416f9bd8f7d3359cbaa261df58de9fed545cdc128be5af4c5cfcfc3a331c"} 03:52:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:24 INFO - Copying logs to upload dir... 03:52:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.380110 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-30 03:52:24.117948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 03:52:24.121475) ========= 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=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48da62fee593be07e2732c15f94023dacb72e59fd768b029032e81f8633cb427d8ace774f6603435b4c8b52e409fbec69be6f38ff5420587075163caceabe3e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e1c41d256bc9f9c03adbd8ce5e61f285ce48506018a5b8cc772d66ef199160c577416f9bd8f7d3359cbaa261df58de9fed545cdc128be5af4c5cfcfc3a331c"} build_url:https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/F3Rs6y_sQ8yDgmp-MsF8NA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48da62fee593be07e2732c15f94023dacb72e59fd768b029032e81f8633cb427d8ace774f6603435b4c8b52e409fbec69be6f38ff5420587075163caceabe3e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91e1c41d256bc9f9c03adbd8ce5e61f285ce48506018a5b8cc772d66ef199160c577416f9bd8f7d3359cbaa261df58de9fed545cdc128be5af4c5cfcfc3a331c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 03:52:24.147355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:52:24.147942) ========= 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=cbe409c6de289db6ac707de3000001d4-1462008592.948375-2107848689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004350 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:52:24.231883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 03:52:24.232205) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 03:52:24.232491) ========= ========= Total master_lag: 0.21 =========