builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1461376518.3 results: success (0) buildid: 20160422163023 builduid: 990e57531c33475a8544e1a09f96fb15 revision: fb0d7b82c072b81ec2d2551dd832f48c287527f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.304413) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.304886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.305182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.328337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.328872) ========= 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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 18:55:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2016-04-22 18:55:18 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.470084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.470400) ========= 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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016934 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.519875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.520235) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fb0d7b82c072b81ec2d2551dd832f48c287527f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fb0d7b82c072b81ec2d2551dd832f48c287527f9 --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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 18:55:18,714 truncating revision to first 12 chars 2016-04-22 18:55:18,714 Setting DEBUG logging. 2016-04-22 18:55:18,714 attempt 1/10 2016-04-22 18:55:18,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fb0d7b82c072?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 18:55:19,066 unpacking tar archive at: mozilla-inbound-fb0d7b82c072/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640276 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.173564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.173883) ========= script_repo_revision: fb0d7b82c072b81ec2d2551dd832f48c287527f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.174306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.174573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.182876) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-22 18:55:19.183688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:55:19 INFO - MultiFileLogger online at 20160422 18:55:19 in /builds/slave/test 18:55:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:55:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:55:19 INFO - {'append_to_log': False, 18:55:19 INFO - 'base_work_dir': '/builds/slave/test', 18:55:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:55:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:55:19 INFO - 'branch': 'Mozilla-Inbound', 18:55:19 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:19 INFO - 'config_files': ('talos/linux_config.py',), 18:55:19 INFO - 'default_actions': ('clobber', 18:55:19 INFO - 'read-buildbot-config', 18:55:19 INFO - 'download-and-extract', 18:55:19 INFO - 'populate-webroot', 18:55:19 INFO - 'create-virtualenv', 18:55:19 INFO - 'install', 18:55:19 INFO - 'run-tests'), 18:55:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:19 INFO - 'download_minidump_stackwalk': True, 18:55:19 INFO - 'download_symbols': 'ondemand', 18:55:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:19 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:19 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:19 INFO - 'installer_path': 'installer.exe', 18:55:19 INFO - 'log_level': 'info', 18:55:19 INFO - 'log_name': 'talos', 18:55:19 INFO - 'log_to_console': True, 18:55:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:55:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:55:19 INFO - 'opt_config_files': (), 18:55:19 INFO - 'pip_index': False, 18:55:19 INFO - 'sps_profile': False, 18:55:19 INFO - 'sps_profile_interval': 0, 18:55:19 INFO - 'suite': 'dromaeojs', 18:55:19 INFO - 'system_bits': '32', 18:55:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:19 INFO - 'title': 'talos-linux64-ix-016', 18:55:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:19 INFO - 'use_talos_json': True, 18:55:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:55:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:19 INFO - 'work_dir': 'build'} 18:55:19 INFO - ##### 18:55:19 INFO - ##### Running clobber step. 18:55:19 INFO - ##### 18:55:19 INFO - Running pre-action listener: _resource_record_pre_action 18:55:19 INFO - Running main action method: clobber 18:55:19 INFO - rmtree: /builds/slave/test/build 18:55:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:55:19 INFO - Running post-action listener: _resource_record_post_action 18:55:19 INFO - ##### 18:55:19 INFO - ##### Running read-buildbot-config step. 18:55:19 INFO - ##### 18:55:19 INFO - Running pre-action listener: _resource_record_pre_action 18:55:19 INFO - Running main action method: read_buildbot_config 18:55:19 INFO - Using buildbot properties: 18:55:19 INFO - { 18:55:19 INFO - "project": "", 18:55:19 INFO - "product": "firefox", 18:55:19 INFO - "script_repo_revision": "production", 18:55:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:55:19 INFO - "repository": "", 18:55:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:55:19 INFO - "buildid": "20160422163023", 18:55:19 INFO - "pgo_build": "True", 18:55:19 INFO - "basedir": "/builds/slave/test", 18:55:19 INFO - "buildnumber": 891, 18:55:19 INFO - "slavename": "talos-linux64-ix-016", 18:55:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:55:19 INFO - "platform": "ubuntu64_hw", 18:55:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:55:19 INFO - "branch": "mozilla-inbound", 18:55:19 INFO - "repo_path": "integration/mozilla-inbound", 18:55:19 INFO - "revision": "fb0d7b82c072b81ec2d2551dd832f48c287527f9", 18:55:19 INFO - "stage_platform": "linux64-pgo", 18:55:19 INFO - "builduid": "990e57531c33475a8544e1a09f96fb15", 18:55:19 INFO - "slavebuilddir": "test" 18:55:19 INFO - } 18:55:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:55:19 INFO - Running post-action listener: _resource_record_post_action 18:55:19 INFO - ##### 18:55:19 INFO - ##### Running download-and-extract step. 18:55:19 INFO - ##### 18:55:19 INFO - Running pre-action listener: _resource_record_pre_action 18:55:19 INFO - Running main action method: download_and_extract 18:55:19 INFO - mkdir: /builds/slave/test/build/tests 18:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:19 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:55:24 INFO - Downloaded 1361 bytes. 18:55:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:24 INFO - Using the following test package requirements: 18:55:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:55:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:55:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'jsshell-linux-x86_64.zip'], 18:55:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:55:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:55:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:55:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:55:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:55:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:24 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:28 INFO - Downloaded 23858096 bytes. 18:55:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:29 INFO - Return code: 0 18:55:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:55:29 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')]} 18:55:29 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:31 INFO - Downloaded 23858096 bytes. 18:55:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:32 INFO - Return code: 0 18:55:32 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')]} 18:55:32 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:55:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:55:34 INFO - Downloaded 10840145 bytes. 18:55:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:55:34 INFO - Return code: 0 18:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:34 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:36 INFO - Downloaded 58338750 bytes. 18:55:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:36 INFO - mkdir: /builds/slave/test/properties 18:55:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:55:36 INFO - Writing to file /builds/slave/test/properties/build_url 18:55:36 INFO - Contents: 18:55:36 INFO - build_url:https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:37 INFO - Running post-action listener: _resource_record_post_action 18:55:37 INFO - Running post-action listener: set_extra_try_arguments 18:55:37 INFO - ##### 18:55:37 INFO - ##### Running populate-webroot step. 18:55:37 INFO - ##### 18:55:37 INFO - Running pre-action listener: _resource_record_pre_action 18:55:37 INFO - Running main action method: populate_webroot 18:55:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:37 INFO - '--tppagecycles', 18:55:37 INFO - '7'], 18:55:37 INFO - 'tests': ['tsvgm']}}, 18:55:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:55:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:55:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:55:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['damp', 'tps']}, 18:55:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'tests': ['damp', 'tps']}, 18:55:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['dromaeo_dom']}, 18:55:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'other-e10s': {'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['a11yr', 18:55:37 INFO - 'ts_paint', 18:55:37 INFO - 'tpaint', 18:55:37 INFO - 'sessionrestore', 18:55:37 INFO - 'sessionrestore_no_auto_restore', 18:55:37 INFO - 'tabpaint']}, 18:55:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['tsvgx', 18:55:37 INFO - 'tsvgr_opacity', 18:55:37 INFO - 'tart', 18:55:37 INFO - 'tscrollx', 18:55:37 INFO - 'cart']}, 18:55:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:55:37 INFO - 'tsvgr_opacity', 18:55:37 INFO - 'tart', 18:55:37 INFO - 'tscrollx', 18:55:37 INFO - 'cart']}, 18:55:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'talos_options': ['--disable-e10s'], 18:55:37 INFO - 'tests': ['tp5o']}, 18:55:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'tests': ['tp5o']}, 18:55:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'talos_options': ['--disable-e10s', 18:55:37 INFO - '--xperf_path', 18:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:37 INFO - 'tests': ['tp5n']}, 18:55:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:37 INFO - 'talos_options': ['--xperf_path', 18:55:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:37 INFO - 'tests': ['tp5n']}}, 18:55:37 INFO - 'talos.zip': {'path': '', 18:55:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:37 INFO - Running post-action listener: _resource_record_post_action 18:55:37 INFO - ##### 18:55:37 INFO - ##### Running create-virtualenv step. 18:55:37 INFO - ##### 18:55:37 INFO - Running pre-action listener: _resource_record_pre_action 18:55:37 INFO - Running main action method: create_virtualenv 18:55:37 INFO - Creating virtualenv /builds/slave/test/build/venv 18:55:37 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 18:55:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:55:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:37 INFO - Using real prefix '/usr' 18:55:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:39 INFO - Installing pip.................done. 18:55:39 INFO - Return code: 0 18:55:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:55:39 INFO - Using env: {'DISPLAY': ':0', 18:55:39 INFO - 'HOME': '/home/cltbld', 18:55:39 INFO - 'LANG': 'en_US.UTF-8', 18:55:39 INFO - 'LANGUAGE': 'en_US:en', 18:55:39 INFO - 'LOGNAME': 'cltbld', 18:55:39 INFO - 'MAIL': '/var/mail/cltbld', 18:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:39 INFO - 'MOZ_NO_REMOTE': '1', 18:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:39 INFO - 'NO_EM_RESTART': '1', 18:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:39 INFO - 'PWD': '/builds/slave/test', 18:55:39 INFO - 'SHELL': '/bin/bash', 18:55:39 INFO - 'SHLVL': '1', 18:55:39 INFO - 'TERM': 'linux', 18:55:39 INFO - 'TMOUT': '86400', 18:55:39 INFO - 'USER': 'cltbld', 18:55:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:39 INFO - '_': '/tools/buildbot/bin/python'} 18:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:40 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 18:55:40 INFO - Cleaning up... 18:55:40 INFO - Return code: 0 18:55:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:55:40 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')]} 18:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:40 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')]} 18:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:40 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:40 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 18:55:40 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 18:55:40 INFO - Using env: {'DISPLAY': ':0', 18:55:40 INFO - 'HOME': '/home/cltbld', 18:55:40 INFO - 'LANG': 'en_US.UTF-8', 18:55:40 INFO - 'LANGUAGE': 'en_US:en', 18:55:40 INFO - 'LOGNAME': 'cltbld', 18:55:40 INFO - 'MAIL': '/var/mail/cltbld', 18:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:40 INFO - 'MOZ_NO_REMOTE': '1', 18:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:40 INFO - 'NO_EM_RESTART': '1', 18:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:40 INFO - 'PWD': '/builds/slave/test', 18:55:40 INFO - 'SHELL': '/bin/bash', 18:55:40 INFO - 'SHLVL': '1', 18:55:40 INFO - 'TERM': 'linux', 18:55:40 INFO - 'TMOUT': '86400', 18:55:40 INFO - 'USER': 'cltbld', 18:55:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:40 INFO - '_': '/tools/buildbot/bin/python'} 18:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:40 INFO - Downloading/unpacking psutil>=0.7.1 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:40 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 18:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:42 INFO - Installing collected packages: psutil 18:55:42 INFO - Running setup.py install for psutil 18:55:42 INFO - building 'psutil._psutil_linux' extension 18:55:42 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 18:55:42 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 18:55:42 INFO - building 'psutil._psutil_posix' extension 18:55:42 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 18:55:42 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 18:55:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:42 INFO - Successfully installed psutil 18:55:42 INFO - Cleaning up... 18:55:42 INFO - Return code: 0 18:55:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:42 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:42 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 18:55:42 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 18:55:42 INFO - Using env: {'DISPLAY': ':0', 18:55:42 INFO - 'HOME': '/home/cltbld', 18:55:42 INFO - 'LANG': 'en_US.UTF-8', 18:55:42 INFO - 'LANGUAGE': 'en_US:en', 18:55:42 INFO - 'LOGNAME': 'cltbld', 18:55:42 INFO - 'MAIL': '/var/mail/cltbld', 18:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:42 INFO - 'MOZ_NO_REMOTE': '1', 18:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:42 INFO - 'NO_EM_RESTART': '1', 18:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:42 INFO - 'PWD': '/builds/slave/test', 18:55:42 INFO - 'SHELL': '/bin/bash', 18:55:42 INFO - 'SHLVL': '1', 18:55:42 INFO - 'TERM': 'linux', 18:55:42 INFO - 'TMOUT': '86400', 18:55:42 INFO - 'USER': 'cltbld', 18:55:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:42 INFO - '_': '/tools/buildbot/bin/python'} 18:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:55:43 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 18:55:43 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 18:55:43 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 18:55:43 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 18:55:43 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 18:55:43 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 18:55:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:55:44 INFO - Installing collected packages: mozsystemmonitor 18:55:44 INFO - Running setup.py install for mozsystemmonitor 18:55:45 INFO - Successfully installed mozsystemmonitor 18:55:45 INFO - Cleaning up... 18:55:45 INFO - Return code: 0 18:55:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:55:45 INFO - Using env: {'DISPLAY': ':0', 18:55:45 INFO - 'HOME': '/home/cltbld', 18:55:45 INFO - 'LANG': 'en_US.UTF-8', 18:55:45 INFO - 'LANGUAGE': 'en_US:en', 18:55:45 INFO - 'LOGNAME': 'cltbld', 18:55:45 INFO - 'MAIL': '/var/mail/cltbld', 18:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:45 INFO - 'MOZ_NO_REMOTE': '1', 18:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:45 INFO - 'NO_EM_RESTART': '1', 18:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:45 INFO - 'PWD': '/builds/slave/test', 18:55:45 INFO - 'SHELL': '/bin/bash', 18:55:45 INFO - 'SHLVL': '1', 18:55:45 INFO - 'TERM': 'linux', 18:55:45 INFO - 'TMOUT': '86400', 18:55:45 INFO - 'USER': 'cltbld', 18:55:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:45 INFO - '_': '/tools/buildbot/bin/python'} 18:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 18:55:45 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 18:55:45 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 18:55:45 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 18:55:45 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 18:55:45 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 18:55:45 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 18:55:47 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:55:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:55:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:47 INFO - Downloading docopt-0.6.1.tar.gz 18:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:55:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:55:47 INFO - Running setup.py install for blobuploader 18:55:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:55:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:55:48 INFO - Running setup.py install for requests 18:55:48 INFO - Running setup.py install for docopt 18:55:48 INFO - Successfully installed blobuploader requests docopt 18:55:48 INFO - Cleaning up... 18:55:48 INFO - Return code: 0 18:55:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:48 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:48 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 18:55:48 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 18:55:48 INFO - Using env: {'DISPLAY': ':0', 18:55:48 INFO - 'HOME': '/home/cltbld', 18:55:48 INFO - 'LANG': 'en_US.UTF-8', 18:55:48 INFO - 'LANGUAGE': 'en_US:en', 18:55:48 INFO - 'LOGNAME': 'cltbld', 18:55:48 INFO - 'MAIL': '/var/mail/cltbld', 18:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:48 INFO - 'MOZ_NO_REMOTE': '1', 18:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:48 INFO - 'NO_EM_RESTART': '1', 18:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:48 INFO - 'PWD': '/builds/slave/test', 18:55:48 INFO - 'SHELL': '/bin/bash', 18:55:48 INFO - 'SHLVL': '1', 18:55:48 INFO - 'TERM': 'linux', 18:55:48 INFO - 'TMOUT': '86400', 18:55:48 INFO - 'USER': 'cltbld', 18:55:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:48 INFO - '_': '/tools/buildbot/bin/python'} 18:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:48 INFO - Running setup.py (path:/tmp/pip-vjY52c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:48 INFO - Running setup.py (path:/tmp/pip-AZvAX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:48 INFO - Running setup.py (path:/tmp/pip-dMwxTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:48 INFO - Running setup.py (path:/tmp/pip-ynWk3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:49 INFO - Running setup.py (path:/tmp/pip-dhQw8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:49 INFO - Running setup.py (path:/tmp/pip-iOCP1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:49 INFO - Running setup.py (path:/tmp/pip-c2XZgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:49 INFO - Running setup.py (path:/tmp/pip-frVsWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:49 INFO - Running setup.py (path:/tmp/pip-BcrAow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:49 INFO - Running setup.py (path:/tmp/pip-QiSYNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:49 INFO - Running setup.py (path:/tmp/pip-0h6yZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:49 INFO - Running setup.py (path:/tmp/pip-eJcgOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:49 INFO - Running setup.py (path:/tmp/pip-x7BdHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:49 INFO - Running setup.py (path:/tmp/pip-M6n_Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:49 INFO - Running setup.py (path:/tmp/pip-XSzgZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:49 INFO - Running setup.py (path:/tmp/pip-aAyWqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:49 INFO - Running setup.py (path:/tmp/pip-V0QjJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:55:49 INFO - Running setup.py install for manifestparser 18:55:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for mozcrash 18:55:50 INFO - Running setup.py install for mozdebug 18:55:50 INFO - Running setup.py install for mozdevice 18:55:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for mozfile 18:55:50 INFO - Running setup.py install for mozhttpd 18:55:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for mozinfo 18:55:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for mozInstall 18:55:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for mozleak 18:55:50 INFO - Running setup.py install for mozlog 18:55:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:55:50 INFO - Running setup.py install for moznetwork 18:55:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Running setup.py install for mozprocess 18:55:51 INFO - Running setup.py install for mozprofile 18:55:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Running setup.py install for mozrunner 18:55:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Running setup.py install for mozscreenshot 18:55:51 INFO - Running setup.py install for moztest 18:55:51 INFO - Running setup.py install for mozversion 18:55:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:55:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:51 INFO - Cleaning up... 18:55:51 INFO - Return code: 0 18:55:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:51 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:51 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 18:55:51 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 18:55:51 INFO - Using env: {'DISPLAY': ':0', 18:55:51 INFO - 'HOME': '/home/cltbld', 18:55:51 INFO - 'LANG': 'en_US.UTF-8', 18:55:51 INFO - 'LANGUAGE': 'en_US:en', 18:55:51 INFO - 'LOGNAME': 'cltbld', 18:55:51 INFO - 'MAIL': '/var/mail/cltbld', 18:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:51 INFO - 'MOZ_NO_REMOTE': '1', 18:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:51 INFO - 'NO_EM_RESTART': '1', 18:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:51 INFO - 'PWD': '/builds/slave/test', 18:55:51 INFO - 'SHELL': '/bin/bash', 18:55:51 INFO - 'SHLVL': '1', 18:55:51 INFO - 'TERM': 'linux', 18:55:51 INFO - 'TMOUT': '86400', 18:55:51 INFO - 'USER': 'cltbld', 18:55:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:51 INFO - '_': '/tools/buildbot/bin/python'} 18:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:51 INFO - Running setup.py (path:/tmp/pip-smnDPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:52 INFO - Running setup.py (path:/tmp/pip-rILcRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:52 INFO - Running setup.py (path:/tmp/pip-9xyfwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:52 INFO - Running setup.py (path:/tmp/pip-qQ3T5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:52 INFO - Running setup.py (path:/tmp/pip-MDrILO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:52 INFO - Running setup.py (path:/tmp/pip-jaXvfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:52 INFO - Running setup.py (path:/tmp/pip-u4TfyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:52 INFO - Running setup.py (path:/tmp/pip-STQ2v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:52 INFO - Running setup.py (path:/tmp/pip-lMIJR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:52 INFO - Running setup.py (path:/tmp/pip-J1Z6r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:52 INFO - Running setup.py (path:/tmp/pip-QQutvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:52 INFO - Running setup.py (path:/tmp/pip-cpG39n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:52 INFO - Running setup.py (path:/tmp/pip-bFtZfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:52 INFO - Running setup.py (path:/tmp/pip-ImUyqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:52 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)) 18:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:52 INFO - Running setup.py (path:/tmp/pip-z_j92m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:53 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)) 18:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:53 INFO - Running setup.py (path:/tmp/pip-y47hAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:53 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)) 18:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:53 INFO - Running setup.py (path:/tmp/pip-7TUCOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:53 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)) 18:55:53 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)) 18:55:53 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)) 18:55:53 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)) 18:55:53 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)) 18:55:53 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)) 18:55:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:55 INFO - Downloading blessings-1.6.tar.gz 18:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:55:55 INFO - Installing collected packages: blessings 18:55:55 INFO - Running setup.py install for blessings 18:55:55 INFO - Successfully installed blessings 18:55:55 INFO - Cleaning up... 18:55:55 INFO - Return code: 0 18:55:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:55:55 INFO - Reading from file tmpfile_stdout 18:55:55 INFO - Current package versions: 18:55:55 INFO - argparse == 1.2.1 18:55:55 INFO - blessings == 1.6 18:55:55 INFO - blobuploader == 1.2.4 18:55:55 INFO - docopt == 0.6.1 18:55:55 INFO - manifestparser == 1.1 18:55:55 INFO - mozInstall == 1.12 18:55:55 INFO - mozcrash == 0.17 18:55:55 INFO - mozdebug == 0.1 18:55:55 INFO - mozdevice == 0.48 18:55:55 INFO - mozfile == 1.2 18:55:55 INFO - mozhttpd == 0.7 18:55:55 INFO - mozinfo == 0.9 18:55:55 INFO - mozleak == 0.1 18:55:55 INFO - mozlog == 3.1 18:55:55 INFO - moznetwork == 0.27 18:55:55 INFO - mozprocess == 0.22 18:55:55 INFO - mozprofile == 0.28 18:55:55 INFO - mozrunner == 6.11 18:55:55 INFO - mozscreenshot == 0.1 18:55:55 INFO - mozsystemmonitor == 0.0 18:55:55 INFO - moztest == 0.7 18:55:55 INFO - mozversion == 1.4 18:55:55 INFO - psutil == 3.1.1 18:55:55 INFO - requests == 1.2.3 18:55:55 INFO - wsgiref == 0.1.2 18:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:55 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:55 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 18:55:55 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 18:55:55 INFO - Using env: {'DISPLAY': ':0', 18:55:55 INFO - 'HOME': '/home/cltbld', 18:55:55 INFO - 'LANG': 'en_US.UTF-8', 18:55:55 INFO - 'LANGUAGE': 'en_US:en', 18:55:55 INFO - 'LOGNAME': 'cltbld', 18:55:55 INFO - 'MAIL': '/var/mail/cltbld', 18:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:55 INFO - 'MOZ_NO_REMOTE': '1', 18:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:55 INFO - 'NO_EM_RESTART': '1', 18:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:55 INFO - 'PWD': '/builds/slave/test', 18:55:55 INFO - 'SHELL': '/bin/bash', 18:55:55 INFO - 'SHLVL': '1', 18:55:55 INFO - 'TERM': 'linux', 18:55:55 INFO - 'TMOUT': '86400', 18:55:55 INFO - 'USER': 'cltbld', 18:55:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:55 INFO - '_': '/tools/buildbot/bin/python'} 18:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 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)) 18:55:55 INFO - Cleaning up... 18:55:55 INFO - Return code: 0 18:55:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:55 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:55 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 18:55:55 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 18:55:55 INFO - Using env: {'DISPLAY': ':0', 18:55:55 INFO - 'HOME': '/home/cltbld', 18:55:55 INFO - 'LANG': 'en_US.UTF-8', 18:55:55 INFO - 'LANGUAGE': 'en_US:en', 18:55:55 INFO - 'LOGNAME': 'cltbld', 18:55:55 INFO - 'MAIL': '/var/mail/cltbld', 18:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:55 INFO - 'MOZ_NO_REMOTE': '1', 18:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:55 INFO - 'NO_EM_RESTART': '1', 18:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:55 INFO - 'PWD': '/builds/slave/test', 18:55:55 INFO - 'SHELL': '/bin/bash', 18:55:55 INFO - 'SHLVL': '1', 18:55:55 INFO - 'TERM': 'linux', 18:55:55 INFO - 'TMOUT': '86400', 18:55:55 INFO - 'USER': 'cltbld', 18:55:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:55 INFO - '_': '/tools/buildbot/bin/python'} 18:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:55 INFO - Downloading/unpacking jsonschema 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:55:57 INFO - Downloading/unpacking functools32 (from jsonschema) 18:55:57 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 18:55:57 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 18:55:57 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 18:55:57 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 18:55:57 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 18:55:57 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 18:55:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:55:58 INFO - warning: no files found matching '*.txt' 18:55:58 INFO - no previously-included directories found matching 'build' 18:55:58 INFO - no previously-included directories found matching 'dist' 18:55:58 INFO - no previously-included directories found matching '.git*' 18:55:58 INFO - Installing collected packages: jsonschema, functools32 18:55:58 INFO - Running setup.py install for functools32 18:55:58 INFO - warning: no files found matching '*.txt' 18:55:58 INFO - no previously-included directories found matching 'build' 18:55:58 INFO - no previously-included directories found matching 'dist' 18:55:58 INFO - no previously-included directories found matching '.git*' 18:55:58 INFO - Successfully installed jsonschema functools32 18:55:58 INFO - Cleaning up... 18:55:58 INFO - Return code: 0 18:55:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:58 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 0x7f8bf45c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, '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': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', '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 18:55:58 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 18:55:58 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 18:55:58 INFO - Using env: {'DISPLAY': ':0', 18:55:58 INFO - 'HOME': '/home/cltbld', 18:55:58 INFO - 'LANG': 'en_US.UTF-8', 18:55:58 INFO - 'LANGUAGE': 'en_US:en', 18:55:58 INFO - 'LOGNAME': 'cltbld', 18:55:58 INFO - 'MAIL': '/var/mail/cltbld', 18:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:58 INFO - 'MOZ_NO_REMOTE': '1', 18:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:58 INFO - 'NO_EM_RESTART': '1', 18:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:58 INFO - 'PWD': '/builds/slave/test', 18:55:58 INFO - 'SHELL': '/bin/bash', 18:55:58 INFO - 'SHLVL': '1', 18:55:58 INFO - 'TERM': 'linux', 18:55:58 INFO - 'TMOUT': '86400', 18:55:58 INFO - 'USER': 'cltbld', 18:55:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:58 INFO - '_': '/tools/buildbot/bin/python'} 18:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:58 INFO - Downloading/unpacking flake8 18:55:58 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 18:55:58 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 18:55:58 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 18:55:58 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 18:55:58 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 18:55:58 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 18:56:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:56:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:56:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:01 INFO - no previously-included directories found matching 'docs/_build' 18:56:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:56:01 INFO - Running setup.py install for pep8 18:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:01 INFO - no previously-included directories found matching 'docs/_build' 18:56:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:56:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:56:01 INFO - Cleaning up... 18:56:01 INFO - Return code: 0 18:56:01 INFO - Running post-action listener: _resource_record_post_action 18:56:01 INFO - Running post-action listener: _start_resource_monitoring 18:56:01 INFO - Starting resource monitoring. 18:56:01 INFO - ##### 18:56:01 INFO - ##### Running install step. 18:56:01 INFO - ##### 18:56:01 INFO - Running pre-action listener: _resource_record_pre_action 18:56:01 INFO - Running main action method: install 18:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:01 INFO - Reading from file tmpfile_stdout 18:56:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:56:01 INFO - Reading from file tmpfile_stdout 18:56:01 INFO - Output received: 18:56:01 INFO - Usage: mozinstall [options] installer 18:56:01 INFO - Options: 18:56:01 INFO - -h, --help show this help message and exit 18:56:01 INFO - -d DEST, --destination=DEST 18:56:01 INFO - Directory to install application into. [default: 18:56:01 INFO - "/builds/slave/test"] 18:56:01 INFO - --app=APP Application being installed. [default: firefox] 18:56:01 INFO - mkdir: /builds/slave/test/build/application 18:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:56:18 INFO - Reading from file tmpfile_stdout 18:56:18 INFO - Output received: 18:56:18 INFO - /builds/slave/test/build/application/firefox/firefox 18:56:18 INFO - Running post-action listener: _resource_record_post_action 18:56:18 INFO - ##### 18:56:18 INFO - ##### Running run-tests step. 18:56:18 INFO - ##### 18:56:18 INFO - Running pre-action listener: _resource_record_pre_action 18:56:18 INFO - Running main action method: run_tests 18:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:56:18 INFO - Python 2.7.3 18:56:18 INFO - Return code: 0 18:56:18 INFO - grabbing minidump binary from tooltool 18:56:18 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')]} 18:56:18 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 0x1758410>, '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 0x1759310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17597a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:56:18 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 18:56:18 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 18:56:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:18 INFO - Return code: 0 18:56:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:56:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:56:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:56:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:56:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:56:19 INFO - Return code: 0 18:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:56:19 INFO - Using env: {'DISPLAY': ':0', 18:56:19 INFO - 'HOME': '/home/cltbld', 18:56:19 INFO - 'LANG': 'en_US.UTF-8', 18:56:19 INFO - 'LANGUAGE': 'en_US:en', 18:56:19 INFO - 'LOGNAME': 'cltbld', 18:56:19 INFO - 'MAIL': '/var/mail/cltbld', 18:56:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:56:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:19 INFO - 'MOZ_NO_REMOTE': '1', 18:56:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:19 INFO - 'NO_EM_RESTART': '1', 18:56:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:19 INFO - 'PWD': '/builds/slave/test', 18:56:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:56:19 INFO - 'SHELL': '/bin/bash', 18:56:19 INFO - 'SHLVL': '1', 18:56:19 INFO - 'TERM': 'linux', 18:56:19 INFO - 'TMOUT': '86400', 18:56:19 INFO - 'USER': 'cltbld', 18:56:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596', 18:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:19 INFO - '_': '/tools/buildbot/bin/python'} 18:56:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:56:19 INFO - mozversion application_buildid: 20160422163023 18:56:19 INFO - mozversion application_changeset: fb0d7b82c072b81ec2d2551dd832f48c287527f9 18:56:19 INFO - mozversion application_display_name: Nightly 18:56:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:19 INFO - mozversion application_name: Firefox 18:56:19 INFO - mozversion application_remotingname: firefox 18:56:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:19 INFO - mozversion application_vendor: Mozilla 18:56:19 INFO - mozversion application_version: 48.0a1 18:56:19 INFO - mozversion platform_buildid: 20160422163023 18:56:19 INFO - mozversion platform_changeset: fb0d7b82c072b81ec2d2551dd832f48c287527f9 18:56:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:19 INFO - mozversion platform_version: 48.0a1 18:56:19 INFO - using testdate: 1461376579 18:56:19 INFO - actual date: 1461376579 18:56:19 INFO - starting webserver on 'localhost:50251' 18:56:19 INFO - SUITE-START | Running 2 tests 18:56:19 INFO - TEST-START | dromaeo_css 18:56:19 INFO - operating with platform_type : linux_ 18:56:19 INFO - Initialising browser for dromaeo_css test... 18:56:19 INFO - TEST-INFO | started process 32013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3r9fVx/profile http://localhost:50251/getInfo.html) 18:56:23 INFO - PROCESS | 32013 | __metrics Screen width/height:1600/1200 18:56:23 INFO - PROCESS | 32013 | colorDepth:24 18:56:23 INFO - PROCESS | 32013 | Browser inner width/height: 1024/697 18:56:23 INFO - PROCESS | 32013 | __metrics 18:56:24 ERROR - PROCESS | 32013 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:56:25 INFO - TEST-INFO | 32013: exit 0 18:56:25 INFO - Browser initialized. 18:56:25 INFO - Running cycle 1/1 for dromaeo_css test... 18:56:25 INFO - TEST-INFO | started process 32095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3r9fVx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:37 INFO - PROCESS | 32095 | RSS: Main: 153329664 18:56:37 INFO - PROCESS | 32095 | 18:57:28 INFO - PROCESS | 32095 | 1461376648014 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] 18:59:35 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50251/tests/dromaeo/cssquery-ext.html) 18:59:36 INFO - PROCESS | 32095 | RSS: Main: 245014528 18:59:36 INFO - PROCESS | 32095 | 19:02:38 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-ext.html (next: http://localhost:50251/tests/dromaeo/cssquery-jquery.html) 19:02:39 INFO - PROCESS | 32095 | RSS: Main: 226160640 19:02:39 INFO - PROCESS | 32095 | 19:05:41 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50251/tests/dromaeo/cssquery-mootools.html) 19:05:41 INFO - PROCESS | 32095 | RSS: Main: 235950080 19:05:41 INFO - PROCESS | 32095 | 19:08:43 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50251/tests/dromaeo/cssquery-prototype.html) 19:08:44 INFO - PROCESS | 32095 | RSS: Main: 227713024 19:08:44 INFO - PROCESS | 32095 | 19:11:46 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50251/tests/dromaeo/cssquery-yui.html) 19:11:47 INFO - PROCESS | 32095 | RSS: Main: 221454336 19:11:47 INFO - PROCESS | 32095 | 19:14:49 INFO - PROCESS | 32095 | Cycle 1(1): loaded http://localhost:50251/tests/dromaeo/cssquery-yui.html (next: http://localhost:50251/tests/dromaeo/cssquery-dojo.html) 19:14:50 INFO - PROCESS | 32095 | RSS: Main: 316030976 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | __start_tp_report 19:14:50 INFO - PROCESS | 32095 | _x_x_mozilla_page_load 19:14:50 INFO - PROCESS | 32095 | _x_x_mozilla_page_load_details 19:14:50 INFO - PROCESS | 32095 | |i|pagename|runs| 19:14:50 INFO - PROCESS | 32095 | |0;dojo.html;3059.95410068849;3097.4424603571347;3126.968730312696;3127.437061328961;3161.446746819306;5186.974065129679;5203.817866374678;5216.921746173811;5256;5274.340707411574;5193.688378697271;5205;5209.453007434212;5232.215167724843;5259.13224317988;4609.193391156543;4644.233701439259;4647.88380290492;4697.765111744399;4884.755762211875;4789.832355867546;4841.24960631101;4856.101621200071;4856.150173719602;4871.512848715118;4698.577128058491;4709.576138147566;4730.195866702668;4754.500777418373;4810.6151507879285;4771.785269662873;4784.282357646346;4784.976075119602;4789.233722604366;4823.589994850442;4632.513586073481;4766.880827979294;4774.40319960005;4776.689515181502;4821.614270858323;5156.278121063054;5179.171332586768;5187.325647665779;5214.139666954948;5214.687118772886;5550.4449555044575;5569.610127291091;5593;5594.412586678381;5595.524380427628;5554.2779438673115;5595.860103497404;5619.438056194389;5634.154876768476;5635.633683810539;5250.684958902478;5268;5271.28837606922;5282.894342113174;5319.574434045306;5708.257926469615;5721.57088218377;5721.77112915487;5727.541796656257;5778.27771528559;5375;5479.589030822704;5487.725613719298;5491.2312276281355;5495.203195536705;5602.831915042555;5604.551635869121;5610.943890561042;5612.466815652507;5654.038813401731;5574.052411090043;5579.414161513064;5588.21764952907;5589.944100559023;5592;5422;5519.199716041152;5573.247611572386;5581.665100094007;5585.469380408855;4269.914601707948;4275.593818587229;4279.422277992493;4309.116631090619;4318.41701370311;3822.0827001519433;3839.7696138231795;3843.106180665588;3864.8260828262796;3871.9932817467097;5187.403448603383;5199.558037566773;5267.841964741064;5298.470152984671;5356.303680521585;5559.193916882029;5575.609707320448;5576.581756368208;5578.135389014709;5620.9437905621235;5266.420693723688;5287.312649355559;5287.789885442886;5294.285271488377;5331.81338653153;4723.197056500403;4803.159447096744;4846.8788280292565;4891.510848915151;4897.583705385082;5813.680247586339;5826.533877289807;5830.3586605473365;5835.649861008353;5843.5909486336395;5616.213730077874;5628.662280263197;5629.155626656035;5629.746661400165;5633.0987042073075;5656.6888821115235;5734.942650573441;5790.478856902899;5826.067829147316;5826.475617194473;5479.6164268500825;5484.314460692413;5488.753006114654;5493.258410114583;5500.312460942382;5476.096444086681;5568.136938774496;5577.051901176891;5578.693171875586;5625.381208067028;5461.290032295776;5507.917381239365;5520.585956053393;5529.253550770594;5571.05292100352;5419.024575576276;5436.266104076058;5440.401555828935;5440.836774896759;5442.0748472760515;5264.473552644705;5289.761960711854;5325.547328477122;5372.086745253238;5378.273933019149;5448.101063324507;5506.091494903296;5515.448455154453;5524.198991146181;5576;5374.220737992891;5402.891942161214;5403.216533602685;5406.135018397038;5438.8368348948015 19:14:50 INFO - PROCESS | 32095 | |1;ext.html;599.4874382403045;626.7618305044083;627.5262177056322;648.5751832549679;649.8830210562097;30485.39029219417;37645.81177094114;38693.80653096738;38798.806005969964;38802.22395552087;40413.393799093035;41200.38199427011;41226.175476490454;41258.79370603143;41288.17423651525;7627.5042122261875;8463.407561470684;8651.48091114532;8673.566321683922;9869.259805514579;10023.899761002369;10215.029572190668;10228.181745460382;10229.181665466745;10248.026437488426;10052.14556762676;10294.536745846455;10301.845472317922;10305.433201173932;10310.536025878853;7483.812904677372;7676.040494938133;7677.50096243748;10013.299069065168;10021.498925053755;10147.695569132939;10302.124319432858;10319.535620897077;10323.793524129474;10325.070743633034;41575.37636935448;42471.57528424707;42476.57523424788;42509.78745106285;42511;3375.578052743407;3465.8960231193105;3578.8926332210076;3635.563732352108;3658.359787037258;32323.35353292921;32363.19092022718;32471.51292730611;33135.502967455504;34327.485087723704;3693.593704692482;3696.5933747287777;3707.2029513654693;3728.925421491555;3744.101415660222;311855;313329;313610;313768;314126;54105.45894541004;55373.72313138489;55650.16524752132;55702;55710.72144639332;54697.72651136798;56149;56305.71847140738;56306.43693563094;56420.43579564234;16617.252223649964;16866.409675661293;16935.576610584587;16946.15269236558;16951.40670076566;12900.35498225085;12967.740645187043;12977.805332920014;12979;12979.740405191844;18950.336738214373;19828.09736166809;19847.801521984886;19906.800931990783;19970.400887973385;7180.964095179491;7343.080136308686;7349.448791340671;7385.778426647209;7617.390608751287;961.1205746741792;966.6471737815647;986.6990567876867;1146.6158836789602;1209.25026483579;31723.84138079295;32354.35291294161;32683.509747353808;33115.92720304613;33166.33667326688;1076.9407682577378;1092.7705181911729;1110.5446766825562;1116.0569318925495;1135.4095870147478;16341;16654.12465924781;16897.831021689624;16932.32270709158;17005;489169;492268;496141;496523;497534;55834;56604;56658;56697.43302566921;56712.14931776027;1322.134002228542;1376.8416632087437;1399.4472183487464;1402.614281072713;1404.9789253161211;30198.69801302047;30880.845595772775;31742;31914;32236;48276.27585586149;49390.75304623598;49560.256596150364;49568.504314956386;49589;312277;317391;318932;318995;319104;32833.35833208378;36988.6301136996;37812.81093594514;40055;40904.59095409127;42454.15091698087;42471.150576988905;42811.7859410701;42883.7855810719;43598.12803743971;35594.28811423705;36119.638803611626;36234.63765362418;36738.26523469569;37165.25669486541;35281.82359088188;38246;39166.608333916294;39874.60125398825;40117.79941100393;40304.59695403126;40350.39474407945;40676.38985415162;40686.1862762749;40850.38724419195;32606.83696581502;34088.318233635684;34235.31529369448;34409;34747.30505389928;26308.868455658365;26689.105085488107;26752.33119172036;26898.59652105259;26943 19:14:50 INFO - PROCESS | 32095 | |2;jquery.html;365.3004496389413;369.15095280854035;370.27056698304347;383.83303263080546;399.3291270665285;18558.72161917572;18633.460287233203;19394.22423103076;19484.318048868292;19557.217711291567;16401.507954761346;16512.50462486124;16562.254698538563;17108.657826843457;17151;5546.584006199541;5655.943440565604;5659.688717120557;5684.062129748587;5701.885962280752;3967.424723415103;4044.3326851069687;5816.854578635525;6302.62184268943;6321.7471301148125;6082.482988945945;6207.937920620804;6211.0372892201785;6214.596051256676;6242.344553821851;6069.241344831896;6197.87604247917;6200.410960958701;6210.96894515529;6211;5411.053065713484;5485.561155107622;5487.176923461513;5489.560835133179;5579.9163012554845;19616.313429029917;19907.303244386523;21957.121715131536;22022;22254;2275.2264230161823;2343.250159948817;2474.9144022008013;2626.2252635472582;2667.546517092099;13852.653683657889;13876.722465550632;14121.152730836182;14193.219372934485;14517.927410362987;1945.5622484940916;1958.5789055353025;1979.604079184169;2052.938411847647;2069.617120832636;77939;78828;79846.2498440035;80446;82065.58967205185;9781.364211326241;9953.402795832273;10383.68848934518;10437.538744575766;10561.260711750258;14211.289435528182;14253.50112746049;14272.500462483764;14286.142831430148;14311.856881431053;7634.580098094658;8175.95912020448;8317.41778075529;8354.331653467709;8385.203405676451;7963.8805417918775;8065.314448271963;8079.636416361161;8226.218509241613;8240.752777416687;6389.9680501597195;6408.6475243861105;6489.5781774184525;6496.935030649633;6542.54202205841;1761.4979730776668;1801.5856353038876;1819.2268285978407;1838.724191371305;1845.9261629534938;918.2837386838277;983.5229913491951;1018.1294992781066;1031.9793604127876;1052.7841792432532;18347.724784128248;18425.53936151607;19045.428637140907;19073.332433364765;19299.903500482407;971.3686104032295;983.8032393521324;990.6136606723384;1014.3356101753363;1050.8528805967171;10453.21600879937;10786.083182929382;10834.133269338434;10944.17918656104;10944.781104377867;174964;177432;177810;179107;476153;52596.73701631468;76431.61784191044;79397.60301198573;80837.59581202056;81157.18842811615;1015.1574193419444;1017.8982101789762;1036.124474818777;1040.9011143941314;1071.887451817548;16275.104869232306;16761.91619041946;16888.831111688727;16950.321987120376;17259;30408.543871842383;32204.355912881143;36345.81827090848;37407.251854963295;38395.80802095972;48056;49124.50875491199;49906;51203.231951520014;51588.22617660663;8178;8280.296174825207;8377.685298625514;8548.23065924045;8651.875256216652;13276.933615331862;13557.728845423233;13631.454741810216;13794.241316727275;13797.724045518833;11378.361675405182;11446.255993360404;11609.013233875216;12024.398780060787;12088.576899808464;11464.541418343506;11498.655040348804;11697.473613687574;11773.117016223647;12125.393730313273;11489;11689.473973671375;11903;11917.165798394375;12432.689182770504;8226.30076443509;8338.29124524398;8366.916330836613;8535.615897284513;8591.742247732578;12108.51565937388;12162.331071791137;12192.878071219175;12200.450979705756;12269.386530673251 19:14:50 INFO - PROCESS | 32095 | |3;mootools.html;1320.9009324300669;1501;1514.939402423903;1667.4330727552629;1797.8202179782015;7127.10911136108;7810.062792464898;7990.920090799097;8017.959910200456;8018.799530011753;7803.921960780391;7930.206979302067;7934.682612695499;7948.523088614673;7952.244536768998;1966.2823069579572;2176.379731776444;2178.6078505868936;2203.823694104468;2253.583087128878;2207.5253820428607;2236.39617303328;2239.0484044281197;2239.0595949701164;2244.0574958517464;2129.9893500532476;2183.1049269799387;2189.4635814225535;2190.123950419829;2190.145843121184;1938.176275083084;2152.9031193596247;2215.2135991722866;2216.5899308627954;2220.655798351242;2085.9165633374646;2095;2103.9368818935454;2107.4099252209253;2162.9783702162936;8017.198280171994;8043.235892590194;8115.229053239933;8119.95940020302;8129.146439623813;4732.077244937239;4912.557869791736;4919.975400123012;4923.138450771136;4923.163062279421;3011.8795248190045;3048.4360393327083;3068.70847269509;3156.8737250509953;3179.0621766578683;1002.3685078400633;1017.9898201017969;1026.8049070676623;1027.7995790820794;1035.5081336365242;10922.726931826688;11089.55641774328;11095.167862410352;11107.72230694239;11122.054625356854;4264.744115353089;4411.558844115627;4417.425734654475;4417.469903611523;4475.060237350193;9533;9553.283503737248;9566.808663826685;9590.376625519319;9612.855807162898;4422.889427764331;4959.70241785494;4971.477994810565;5006.224035274538;5011.1481048221885;4478.484974228006;4630.120277147331;4641.8375356863025;4647.697899636512;4654.2785868190485;3708.9072773180346;3732.3841566141828;3798.6581207691443;3802.771833689932;3860.613938606173;1174.5654107980101;1193.2005556277315;1200.6458094862037;1201.9819702704467;1202.4588934979295;902.697596305232;988.619381538113;989.9703008909744;1015.9136473399844;1027.0397178637998;5736.827895163152;5746.655200687972;5747.942520574825;5826.271716035496;5873.2658417697785;412.71316435077335;424.5733038296492;425.28552032585554;427.7658953917907;429.8151794728297;3813.103920578662;3854.383298672199;3859;3883.37865941448;3926.86255981045;9537.14165725088;9797.706068817946;10005.49972501372;10018.74953126163;10106.797864042677;9791.412515249107;9932.056454636799;9993.300468967247;9999.300048996645;10017.148542373834;7268.890966635505;7591.962040189764;7592.013038304985;7666.543356762309;7677.961610192025;5673;5705.486506214461;5782.219400381063;5809.912851307149;5905.704714764331;8810.823783524422;8814.867776983223;8884;8968.834051573254;8990.775230619287;8861.424007439497;9084.454932704059;9086.90913090887;9183.448993060438;9322.720318390458;6372.394622510854;6589.835254118685;6605.900911486236;6930.44556435494;7035.472339574655;7271.890921636285;7387.556746595222;7463.2163622818825;7469.215732348025;7492.925070749223;6678.7328506859185;6823.624700641512;6858.588484690935;7049.718011279697;7145.821354465972;6936.965315173594;6954;6973.267806880204;7025.367716905503;7045.964770176116;6347.873042539031;6369.522285828489;6443.67781610927;6475.449586784987;6477.708503117276;4738.455077665974;4792.137415265286;4795.448523419851;4865.537773911473;4885.682430641997;4640.791164397678;4855.441624213261;4902.2156454967035;4927.260910863256;5022.623303252198 19:14:50 INFO - PROCESS | 32095 | |4;prototype.html;303.37050619963577;303.76761777240415;304.09531643361;307.09866541700126;309.78934324659224;5227.424983251839;5275.868103297415;5296.417394086657;5332.866678333039;5364.746806341336;5183.766730497127;5235.79056837727;5279.208118782185;5286.629935904488;5320.9467905320935;3861.517310336208;3928.8428462861452;3933.4296527003567;3977.806658002602;4001.8999525011964;3922.2155568886196;4061.7002559181074;4073.775942323171;4076.429299898017;4080.2451546464;3975;4015.738976966488;4029.597040295976;4037.4347591337237;4042.454268673721;3829.4064420014943;3998.6801055915603;4024.9798751006056;4026.8590599329177;4042.7776472294013;3482.6343233960574;3488.2674638325984;3506.3162683276773;3515.876944306937;3526.7002304804123;5083.923741143886;5123.436421993578;5126.6667666601925;5140.1518749406305;5155.922661160085;4485.282354823213;4516.525764794715;4563.908721825578;4587.220172570637;4615.538446155391;5453.645513041679;5483.232347471358;5490.80782172626;5495.6153069285165;5510.476504732084;3790.7346485746007;3792.1846802937225;3810.295095407331;3811.1805961718087;3818.083659921627;5427.565794736412;5624.803131890405;5791.797287094973;5801.796937107181;5803.53571714266;3822.369309063973;3827.483289755903;3845.7503409619385;3867.207222519377;3879.8060096995036;3880.165764360676;3887.669548088444;3893.669038131734;3896.3960586109197;3909.7458665186673;4538.659600529907;4543.727376357429;4563.703359281636;4573.839915602938;4579.80924959513;5260.868478288074;5528.640638358494;5541.251930989265;5578.9163162552595;5605.243292155506;1424.8432672406027;1425.8431572527013;1427.7929700193413;1433.5555977646964;1433.7705967045222;889.2574700125467;920.2775820980498;942.0861764088822;954.8997355277735;957.6360982826482;5075.289459475676;5276.604254680914;5305;5577.776888924398;5586.608937374426;5599.832005039855;5645.23789288449;5698.6580805151825;5725.828225153252;5784.2769653793275;5412.890357476708;5419.485148910847;5460.972695136578;5461.672299662033;5501.14732216507;3125.0624812556143;3214.7428205743486;3280.950785738216;3281.6882396172327;3306.487494438366;6331.588446750947;6345.333739957238;6346.619202847752;6350.364963503705;6353.237611486558;6004.579679422399;6233.937660623426;6301.558890877594;6309.716062777186;6353.36466353361;6334.746610135635;6343.207099112611;6351.587146835441;6384.776532821329;6443.6455994920725;5504.614676972574;6124.724387402489;6162.198914141133;6170.50635949114;6183.938160618516;5635.802746903839;5650.29371328584;5650.519705824887;5671.950689122526;5681.147827825859;5928.733207005781;5929.9110513341475;5998.460138587374;5998.49012833914;6003.459688628044;3731.869384571527;3955.426463162883;3963.4847469828737;3964.8017599119353;3987.1826275614007;5727.369989301257;5741.8564535886935;5742.28221472316;5750.6837123958585;5760.711964401679;5589.916151257653;5599.524040456607;5614.6631202128;5639.295088113986;5649.491545760901;5509.3664228614225;5533.529649979797;5547.195656629847;5577.27495425592;5591.30108736408;5203.713795741119;5327.893442131213;5487.259220005249;5496.532794712494;5535.7785688572;5615.848751005952;5632.183333416549;5640.54875609942;5654.519365853948;5657.405972373006;5239.109351410193;5480.534154596904;5495.890082198413;5500.972495137658;5519.227308176778 19:14:50 INFO - PROCESS | 32095 | |5;yui.html;702.8664553734786;740.8666440040794;742.2540346951313;757.3865169212938;776.6815605601704;14647.633809154762;15054.548363549084;15067.095974241553;15124.092554446726;15136.545903622895;13022.934885325583;13053.151545149558;13082.607521774362;13084.803727944065;13088.73822523549;648.8767134244503;765.2003656179306;795.3557618329157;799.7560743973086;812.524673066254;796.0487217774762;799.9280064794167;803.8794180872858;806.0569134113101;807.3944541593804;849.8385306791721;849.9830003399928;851.1190917400461;851.9148085191493;852.3735054734765;683.4907993544816;706.7597017014214;709.0498731699496;825.471698113208;844.7676888855552;622.2874808344466;624.3912185618985;627.6767464755654;628.6071205496564;630.1461519640867;13772.173669579857;13805;13834.654133646638;13836.930815345959;13845.515406960809;12426.813597796041;13180.143290686075;13549.932250338685;13679;13695.657608559766;11222.046126079293;11261.943690281578;11387.25982811123;11453.713657158554;11456.4844581994;3712.443133529965;3783.9432408513894;3798.6391292827416;3800.3349413852743;3845.8461661533506;50759.49240507621;51474;51516;51521.48478515242;51537.484625153644;9386.202172815387;9439.528023598792;9726.925068716931;9768.560414781352;9952.353097048668;16295;16350.75473867893;16353.836461635232;16373.67252654964;16467.34130634785;7376.594287314249;7387.519811212362;7424.331810137113;7478.4765066444825;7640.770776876702;4495.57292057254;4519.276915693474;4526.140033393644;4590;4670.602998745077;3256.5603643507825;3301.356235534096;3317.104381816896;3327.966720332766;3329.517220003086;563.4984863471514;568.1903287814847;571.4628249445508;579.9681017543991;594.5867622002753;692.8995295682199;730.6711979609197;740.8777551703909;754.5585832288173;756.2324240895496;8361.874571881426;8724.214820666171;8825.205731484197;8852.583207902704;8911.55442227886;737.3879679865698;740.9073865766779;744.3858816476428;745.3813334931993;767.3592550220517;4184.937225941613;4192.685548583808;4235.23765722173;4255.914881702411;4267.701260911706;57905;58850.11724824131;59374;60442.39557604455;60728;51211;51483.74258128685;51717;52085;55249.44750552523;47742.04515909732;47984;48852.02295954061;48975.51024489781;49400.25899611509;8290.37822163328;8441.535715535705;8502.277306428776;8581.0560838309;9066.637334506546;32163.356732864744;33138;33697.83151084229;34026;34506.89437950597;43139;43751.12497749963;43986.78006609946;44180.779096104314;44942;11069.391183484986;11113.499892504695;11653.53385864556;11873.346965916957;11877.881221187678;12263.141580089308;12273.509059637514;12289.201201921847;12324.50701971911;12504.062195335204;9776.706698799047;11042.392668403316;11843.822342665038;11873.643790686294;11901.642950711492;10769.407682577534;10824.5128969195;10832.295900766425;11165.88834111681;11182.944085279521;11411.315321080761;11793.941030294794;11933.761324773282;11965.880341196476;12114.333711645944;10159.390436573829;10289.022542858416;10313.639022634172;10316.638917637847;10617.1506279499;9909.398080315681;10156.644517441853;10391.48042597852;10587.417692027013;10673.199510036624 19:14:50 INFO - PROCESS | 32095 | __end_tp_report 19:14:50 INFO - PROCESS | 32095 | __start_cc_report 19:14:50 INFO - PROCESS | 32095 | _x_x_mozilla_cycle_collect,793 19:14:50 INFO - PROCESS | 32095 | __end_cc_report 19:14:50 INFO - PROCESS | 32095 | __startTimestamp1461377690132__endTimestamp 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | ------- Summary: start ------- 19:14:50 INFO - PROCESS | 32095 | Number of tests: 6 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#0] dojo.html Cycles:165 Average:5198.99 Median:5402.89 stddev:574.94 (10.6%) stddev-sans-first:551.67 19:14:50 INFO - PROCESS | 32095 | Values: 3060.0 3097.4 3127.0 3127.4 3161.4 5187.0 5203.8 5216.9 5256.0 5274.3 5193.7 5205.0 5209.5 5232.2 5259.1 4609.2 4644.2 4647.9 4697.8 4884.8 4789.8 4841.2 4856.1 4856.2 4871.5 4698.6 4709.6 4730.2 4754.5 4810.6 4771.8 4784.3 4785.0 4789.2 4823.6 4632.5 4766.9 4774.4 4776.7 4821.6 5156.3 5179.2 5187.3 5214.1 5214.7 5550.4 5569.6 5593.0 5594.4 5595.5 5554.3 5595.9 5619.4 5634.2 5635.6 5250.7 5268.0 5271.3 5282.9 5319.6 5708.3 5721.6 5721.8 5727.5 5778.3 5375.0 5479.6 5487.7 5491.2 5495.2 5602.8 5604.6 5610.9 5612.5 5654.0 5574.1 5579.4 5588.2 5589.9 5592.0 5422.0 5519.2 5573.2 5581.7 5585.5 4269.9 4275.6 4279.4 4309.1 4318.4 3822.1 3839.8 3843.1 3864.8 3872.0 5187.4 5199.6 5267.8 5298.5 5356.3 5559.2 5575.6 5576.6 5578.1 5620.9 5266.4 5287.3 5287.8 5294.3 5331.8 4723.2 4803.2 4846.9 4891.5 4897.6 5813.7 5826.5 5830.4 5835.6 5843.6 5616.2 5628.7 5629.2 5629.7 5633.1 5656.7 5734.9 5790.5 5826.1 5826.5 5479.6 5484.3 5488.8 5493.3 5500.3 5476.1 5568.1 5577.1 5578.7 5625.4 5461.3 5507.9 5520.6 5529.3 5571.1 5419.0 5436.3 5440.4 5440.8 5442.1 5264.5 5289.8 5325.5 5372.1 5378.3 5448.1 5506.1 5515.4 5524.2 5576.0 5374.2 5402.9 5403.2 5406.1 5438.8 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#1] ext.html Cycles:180 Average:54141.60 Median:19849.27 stddev:101497.06 (511.3%) stddev-sans-first:101702.18 19:14:50 INFO - PROCESS | 32095 | Values: 599.5 626.8 627.5 648.6 649.9 30485.4 37645.8 38693.8 38798.8 38802.2 40413.4 41200.4 41226.2 41258.8 41288.2 7627.5 8463.4 8651.5 8673.6 9869.3 10023.9 10215.0 10228.2 10229.2 10248.0 10052.1 10294.5 10301.8 10305.4 10310.5 7483.8 7676.0 7677.5 10013.3 10021.5 10147.7 10302.1 10319.5 10323.8 10325.1 41575.4 42471.6 42476.6 42509.8 42511.0 3375.6 3465.9 3578.9 3635.6 3658.4 32323.4 32363.2 32471.5 33135.5 34327.5 3693.6 3696.6 3707.2 3728.9 3744.1 311855.0 313329.0 313610.0 313768.0 314126.0 54105.5 55373.7 55650.2 55702.0 55710.7 54697.7 56149.0 56305.7 56306.4 56420.4 16617.3 16866.4 16935.6 16946.2 16951.4 12900.4 12967.7 12977.8 12979.0 12979.7 18950.3 19828.1 19847.8 19906.8 19970.4 7181.0 7343.1 7349.4 7385.8 7617.4 961.1 966.6 986.7 1146.6 1209.3 31723.8 32354.4 32683.5 33115.9 33166.3 1076.9 1092.8 1110.5 1116.1 1135.4 16341.0 16654.1 16897.8 16932.3 17005.0 489169.0 492268.0 496141.0 496523.0 497534.0 55834.0 56604.0 56658.0 56697.4 56712.1 1322.1 1376.8 1399.4 1402.6 1405.0 30198.7 30880.8 31742.0 31914.0 32236.0 48276.3 49390.8 49560.3 49568.5 49589.0 312277.0 317391.0 318932.0 318995.0 319104.0 32833.4 36988.6 37812.8 40055.0 40904.6 42454.2 42471.2 42811.8 42883.8 43598.1 35594.3 36119.6 36234.6 36738.3 37165.3 35281.8 38246.0 39166.6 39874.6 40117.8 40304.6 40350.4 40676.4 40686.2 40850.4 32606.8 34088.3 34235.3 34409.0 34747.3 26308.9 26689.1 26752.3 26898.6 26943.0 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#2] jquery.html Cycles:180 Average:21033.44 Median:22138.00 stddev:45432.28 (205.2%) stddev-sans-first:45533.22 19:14:50 INFO - PROCESS | 32095 | Values: 365.3 369.2 370.3 383.8 399.3 18558.7 18633.5 19394.2 19484.3 19557.2 16401.5 16512.5 16562.3 17108.7 17151.0 5546.6 5655.9 5659.7 5684.1 5701.9 3967.4 4044.3 5816.9 6302.6 6321.7 6082.5 6207.9 6211.0 6214.6 6242.3 6069.2 6197.9 6200.4 6211.0 6211.0 5411.1 5485.6 5487.2 5489.6 5579.9 19616.3 19907.3 21957.1 22022.0 22254.0 2275.2 2343.3 2474.9 2626.2 2667.5 13852.7 13876.7 14121.2 14193.2 14517.9 1945.6 1958.6 1979.6 2052.9 2069.6 77939.0 78828.0 79846.2 80446.0 82065.6 9781.4 9953.4 10383.7 10437.5 10561.3 14211.3 14253.5 14272.5 14286.1 14311.9 7634.6 8176.0 8317.4 8354.3 8385.2 7963.9 8065.3 8079.6 8226.2 8240.8 6390.0 6408.6 6489.6 6496.9 6542.5 1761.5 1801.6 1819.2 1838.7 1845.9 918.3 983.5 1018.1 1032.0 1052.8 18347.7 18425.5 19045.4 19073.3 19299.9 971.4 983.8 990.6 1014.3 1050.9 10453.2 10786.1 10834.1 10944.2 10944.8 174964.0 177432.0 177810.0 179107.0 476153.0 52596.7 76431.6 79397.6 80837.6 81157.2 1015.2 1017.9 1036.1 1040.9 1071.9 16275.1 16761.9 16888.8 16950.3 17259.0 30408.5 32204.4 36345.8 37407.3 38395.8 48056.0 49124.5 49906.0 51203.2 51588.2 8178.0 8280.3 8377.7 8548.2 8651.9 13276.9 13557.7 13631.5 13794.2 13797.7 11378.4 11446.3 11609.0 12024.4 12088.6 11464.5 11498.7 11697.5 11773.1 12125.4 11489.0 11689.5 11903.0 11917.2 12432.7 8226.3 8338.3 8366.9 8535.6 8591.7 12108.5 12162.3 12192.9 12200.5 12269.4 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#3] mootools.html Cycles:180 Average:5306.65 Median:4907.39 stddev:2959.71 (60.3%) stddev-sans-first:2952.86 19:14:50 INFO - PROCESS | 32095 | Values: 1320.9 1501.0 1514.9 1667.4 1797.8 7127.1 7810.1 7990.9 8018.0 8018.8 7803.9 7930.2 7934.7 7948.5 7952.2 1966.3 2176.4 2178.6 2203.8 2253.6 2207.5 2236.4 2239.0 2239.1 2244.1 2130.0 2183.1 2189.5 2190.1 2190.1 1938.2 2152.9 2215.2 2216.6 2220.7 2085.9 2095.0 2103.9 2107.4 2163.0 8017.2 8043.2 8115.2 8120.0 8129.1 4732.1 4912.6 4920.0 4923.1 4923.2 3011.9 3048.4 3068.7 3156.9 3179.1 1002.4 1018.0 1026.8 1027.8 1035.5 10922.7 11089.6 11095.2 11107.7 11122.1 4264.7 4411.6 4417.4 4417.5 4475.1 9533.0 9553.3 9566.8 9590.4 9612.9 4422.9 4959.7 4971.5 5006.2 5011.1 4478.5 4630.1 4641.8 4647.7 4654.3 3708.9 3732.4 3798.7 3802.8 3860.6 1174.6 1193.2 1200.6 1202.0 1202.5 902.7 988.6 990.0 1015.9 1027.0 5736.8 5746.7 5747.9 5826.3 5873.3 412.7 424.6 425.3 427.8 429.8 3813.1 3854.4 3859.0 3883.4 3926.9 9537.1 9797.7 10005.5 10018.7 10106.8 9791.4 9932.1 9993.3 9999.3 10017.1 7268.9 7592.0 7592.0 7666.5 7678.0 5673.0 5705.5 5782.2 5809.9 5905.7 8810.8 8814.9 8884.0 8968.8 8990.8 8861.4 9084.5 9086.9 9183.4 9322.7 6372.4 6589.8 6605.9 6930.4 7035.5 7271.9 7387.6 7463.2 7469.2 7492.9 6678.7 6823.6 6858.6 7049.7 7145.8 6937.0 6954.0 6973.3 7025.4 7046.0 6347.9 6369.5 6443.7 6475.4 6477.7 4738.5 4792.1 4795.4 4865.5 4885.7 4640.8 4855.4 4902.2 4927.3 5022.6 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#4] prototype.html Cycles:180 Average:4691.22 Median:5348.81 stddev:1444.17 (27.0%) stddev-sans-first:1410.17 19:14:50 INFO - PROCESS | 32095 | Values: 303.4 303.8 304.1 307.1 309.8 5227.4 5275.9 5296.4 5332.9 5364.7 5183.8 5235.8 5279.2 5286.6 5320.9 3861.5 3928.8 3933.4 3977.8 4001.9 3922.2 4061.7 4073.8 4076.4 4080.2 3975.0 4015.7 4029.6 4037.4 4042.5 3829.4 3998.7 4025.0 4026.9 4042.8 3482.6 3488.3 3506.3 3515.9 3526.7 5083.9 5123.4 5126.7 5140.2 5155.9 4485.3 4516.5 4563.9 4587.2 4615.5 5453.6 5483.2 5490.8 5495.6 5510.5 3790.7 3792.2 3810.3 3811.2 3818.1 5427.6 5624.8 5791.8 5801.8 5803.5 3822.4 3827.5 3845.8 3867.2 3879.8 3880.2 3887.7 3893.7 3896.4 3909.7 4538.7 4543.7 4563.7 4573.8 4579.8 5260.9 5528.6 5541.3 5578.9 5605.2 1424.8 1425.8 1427.8 1433.6 1433.8 889.3 920.3 942.1 954.9 957.6 5075.3 5276.6 5305.0 5577.8 5586.6 5599.8 5645.2 5698.7 5725.8 5784.3 5412.9 5419.5 5461.0 5461.7 5501.1 3125.1 3214.7 3281.0 3281.7 3306.5 6331.6 6345.3 6346.6 6350.4 6353.2 6004.6 6233.9 6301.6 6309.7 6353.4 6334.7 6343.2 6351.6 6384.8 6443.6 5504.6 6124.7 6162.2 6170.5 6183.9 5635.8 5650.3 5650.5 5672.0 5681.1 5928.7 5929.9 5998.5 5998.5 6003.5 3731.9 3955.4 3963.5 3964.8 3987.2 5727.4 5741.9 5742.3 5750.7 5760.7 5589.9 5599.5 5614.7 5639.3 5649.5 5509.4 5533.5 5547.2 5577.3 5591.3 5203.7 5327.9 5487.3 5496.5 5535.8 5615.8 5632.2 5640.5 5654.5 5657.4 5239.1 5480.5 5495.9 5501.0 5519.2 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - PROCESS | 32095 | [#5] yui.html Cycles:180 Average:14103.28 Median:4558.07 stddev:16370.43 (359.2%) stddev-sans-first:16385.43 19:14:50 INFO - PROCESS | 32095 | Values: 702.9 740.9 742.3 757.4 776.7 14647.6 15054.5 15067.1 15124.1 15136.5 13022.9 13053.2 13082.6 13084.8 13088.7 648.9 765.2 795.4 799.8 812.5 796.0 799.9 803.9 806.1 807.4 849.8 850.0 851.1 851.9 852.4 683.5 706.8 709.0 825.5 844.8 622.3 624.4 627.7 628.6 630.1 13772.2 13805.0 13834.7 13836.9 13845.5 12426.8 13180.1 13549.9 13679.0 13695.7 11222.0 11261.9 11387.3 11453.7 11456.5 3712.4 3783.9 3798.6 3800.3 3845.8 50759.5 51474.0 51516.0 51521.5 51537.5 9386.2 9439.5 9726.9 9768.6 9952.4 16295.0 16350.8 16353.8 16373.7 16467.3 7376.6 7387.5 7424.3 7478.5 7640.8 4495.6 4519.3 4526.1 4590.0 4670.6 3256.6 3301.4 3317.1 3328.0 3329.5 563.5 568.2 571.5 580.0 594.6 692.9 730.7 740.9 754.6 756.2 8361.9 8724.2 8825.2 8852.6 8911.6 737.4 740.9 744.4 745.4 767.4 4184.9 4192.7 4235.2 4255.9 4267.7 57905.0 58850.1 59374.0 60442.4 60728.0 51211.0 51483.7 51717.0 52085.0 55249.4 47742.0 47984.0 48852.0 48975.5 49400.3 8290.4 8441.5 8502.3 8581.1 9066.6 32163.4 33138.0 33697.8 34026.0 34506.9 43139.0 43751.1 43986.8 44180.8 44942.0 11069.4 11113.5 11653.5 11873.3 11877.9 12263.1 12273.5 12289.2 12324.5 12504.1 9776.7 11042.4 11843.8 11873.6 11901.6 10769.4 10824.5 10832.3 11165.9 11182.9 11411.3 11793.9 11933.8 11965.9 12114.3 10159.4 10289.0 10313.6 10316.6 10617.2 9909.4 10156.6 10391.5 10587.4 10673.2 19:14:50 INFO - PROCESS | 32095 | -------- Summary: end -------- 19:14:50 INFO - PROCESS | 32095 | 19:14:50 INFO - TEST-INFO | 32095: exit 0 19:14:50 INFO - TEST-OK | dromaeo_css | took 1111353ms 19:14:50 INFO - TEST-START | kraken 19:14:50 INFO - operating with platform_type : linux_ 19:14:50 INFO - Initialising browser for kraken test... 19:14:50 INFO - TEST-INFO | started process 32277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_Ts8t/profile http://localhost:50251/getInfo.html) 19:14:54 INFO - PROCESS | 32277 | __metrics Screen width/height:1600/1200 19:14:54 INFO - PROCESS | 32277 | colorDepth:24 19:14:54 INFO - PROCESS | 32277 | Browser inner width/height: 1024/697 19:14:54 INFO - PROCESS | 32277 | __metrics 19:14:55 ERROR - PROCESS | 32277 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:14:56 INFO - TEST-INFO | 32277: exit 0 19:14:56 INFO - Browser initialized. 19:14:56 INFO - Running cycle 1/1 for kraken test... 19:14:56 INFO - TEST-INFO | started process 32361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd_Ts8t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:08 INFO - PROCESS | 32361 | RSS: Main: 153776128 19:15:08 INFO - PROCESS | 32361 | 19:15:10 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50251/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:11 INFO - PROCESS | 32361 | RSS: Main: 208818176 19:15:11 INFO - PROCESS | 32361 | 19:15:14 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50251/tests/kraken/driver.html?testName=audio-dft) 19:15:15 INFO - PROCESS | 32361 | RSS: Main: 193601536 19:15:15 INFO - PROCESS | 32361 | 19:15:18 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50251/tests/kraken/driver.html?testName=audio-fft) 19:15:18 INFO - PROCESS | 32361 | RSS: Main: 265510912 19:15:18 INFO - PROCESS | 32361 | 19:15:20 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50251/tests/kraken/driver.html?testName=audio-oscillator) 19:15:21 INFO - PROCESS | 32361 | RSS: Main: 172789760 19:15:21 INFO - PROCESS | 32361 | 19:15:23 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:15:24 INFO - PROCESS | 32361 | RSS: Main: 177590272 19:15:24 INFO - PROCESS | 32361 | 19:15:27 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50251/tests/kraken/driver.html?testName=imaging-darkroom) 19:15:27 INFO - PROCESS | 32361 | RSS: Main: 213917696 19:15:27 INFO - PROCESS | 32361 | 19:15:31 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50251/tests/kraken/driver.html?testName=imaging-desaturate) 19:15:31 INFO - PROCESS | 32361 | RSS: Main: 214917120 19:15:31 INFO - PROCESS | 32361 | 19:15:34 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50251/tests/kraken/driver.html?testName=json-parse-financial) 19:15:35 INFO - PROCESS | 32361 | RSS: Main: 214740992 19:15:35 INFO - PROCESS | 32361 | 19:15:36 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:15:37 INFO - PROCESS | 32361 | RSS: Main: 203493376 19:15:37 INFO - PROCESS | 32361 | 19:15:39 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:15:39 INFO - PROCESS | 32361 | RSS: Main: 206663680 19:15:39 INFO - PROCESS | 32361 | 19:15:41 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:15:42 INFO - PROCESS | 32361 | RSS: Main: 215441408 19:15:42 INFO - PROCESS | 32361 | 19:15:44 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:15:45 INFO - PROCESS | 32361 | RSS: Main: 222638080 19:15:45 INFO - PROCESS | 32361 | 19:15:48 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:49 INFO - PROCESS | 32361 | RSS: Main: 219537408 19:15:49 INFO - PROCESS | 32361 | 19:15:50 INFO - PROCESS | 32361 | Cycle 1(1): loaded http://localhost:50251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50251/tests/kraken/driver.html?testName=ai-astar) 19:15:51 INFO - PROCESS | 32361 | RSS: Main: 283369472 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | __start_tp_report 19:15:51 INFO - PROCESS | 32361 | _x_x_mozilla_page_load 19:15:51 INFO - PROCESS | 32361 | _x_x_mozilla_page_load_details 19:15:51 INFO - PROCESS | 32361 | |i|pagename|runs| 19:15:51 INFO - PROCESS | 32361 | |0;ai-astar;113;111;107;111;111;112;100;112;110;111 19:15:51 INFO - PROCESS | 32361 | |1;audio-beat-detection;158;126;160;188;130;155;154;129;189;127 19:15:51 INFO - PROCESS | 32361 | |2;audio-dft;161;161;162;161;161;160;161;162;162;162 19:15:51 INFO - PROCESS | 32361 | |3;audio-fft;76;73;106;117;77;72;74;129;105;74 19:15:51 INFO - PROCESS | 32361 | |4;audio-oscillator;92;93;154;91;93;94;158;92;92;144 19:15:51 INFO - PROCESS | 32361 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;116;117 19:15:51 INFO - PROCESS | 32361 | |6;imaging-darkroom;145;146;145;145;145;146;145;144;146;145 19:15:51 INFO - PROCESS | 32361 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;95 19:15:51 INFO - PROCESS | 32361 | |8;json-parse-financial;59;58;59;59;58;62;59;77;58;59 19:15:51 INFO - PROCESS | 32361 | |9;json-stringify-tinderbox;61;61;62;61;62;62;61;61;61;61 19:15:51 INFO - PROCESS | 32361 | |10;stanford-crypto-aes;77;76;78;75;77;77;79;79;78;78 19:15:51 INFO - PROCESS | 32361 | |11;stanford-crypto-ccm;131;125;132;125;127;122;122;122;160;127 19:15:51 INFO - PROCESS | 32361 | |12;stanford-crypto-pbkdf2;172;173;169;172;173;175;168;170;179;171 19:15:51 INFO - PROCESS | 32361 | |13;stanford-crypto-sha256-iterative;74;71;71;70;69;69;68;69;68;68 19:15:51 INFO - PROCESS | 32361 | __end_tp_report 19:15:51 INFO - PROCESS | 32361 | __start_cc_report 19:15:51 INFO - PROCESS | 32361 | _x_x_mozilla_cycle_collect,1646 19:15:51 INFO - PROCESS | 32361 | __end_cc_report 19:15:51 INFO - PROCESS | 32361 | __startTimestamp1461377751011__endTimestamp 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | ------- Summary: start ------- 19:15:51 INFO - PROCESS | 32361 | Number of tests: 14 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.79 (3.4%) stddev-sans-first:3.84 19:15:51 INFO - PROCESS | 32361 | Values: 113.0 111.0 107.0 111.0 111.0 112.0 100.0 112.0 110.0 111.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.50 stddev:23.78 (15.2%) stddev-sans-first:25.11 19:15:51 INFO - PROCESS | 32361 | Values: 158.0 126.0 160.0 188.0 130.0 155.0 154.0 129.0 189.0 127.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 19:15:51 INFO - PROCESS | 32361 | Values: 161.0 161.0 162.0 161.0 161.0 160.0 161.0 162.0 162.0 162.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#3] audio-fft Cycles:10 Average:90.30 Median:73.50 stddev:21.65 (29.5%) stddev-sans-first:22.34 19:15:51 INFO - PROCESS | 32361 | Values: 76.0 73.0 106.0 117.0 77.0 72.0 74.0 129.0 105.0 74.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.00 stddev:28.99 (31.5%) stddev-sans-first:29.98 19:15:51 INFO - PROCESS | 32361 | Values: 92.0 93.0 154.0 91.0 93.0 94.0 158.0 92.0 92.0 144.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:15:51 INFO - PROCESS | 32361 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:15:51 INFO - PROCESS | 32361 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 144.0 146.0 145.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:15:51 INFO - PROCESS | 32361 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.00 stddev:5.81 (9.8%) stddev-sans-first:6.12 19:15:51 INFO - PROCESS | 32361 | Values: 59.0 58.0 59.0 59.0 58.0 62.0 59.0 77.0 58.0 59.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 19:15:51 INFO - PROCESS | 32361 | Values: 61.0 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:78.00 stddev:1.26 (1.6%) stddev-sans-first:1.33 19:15:51 INFO - PROCESS | 32361 | Values: 77.0 76.0 78.0 75.0 77.0 77.0 79.0 79.0 78.0 78.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:127.00 stddev:11.35 (8.9%) stddev-sans-first:12.03 19:15:51 INFO - PROCESS | 32361 | Values: 131.0 125.0 132.0 125.0 127.0 122.0 122.0 122.0 160.0 127.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:3.16 (1.8%) stddev-sans-first:3.35 19:15:51 INFO - PROCESS | 32361 | Values: 172.0 173.0 169.0 172.0 173.0 175.0 168.0 170.0 179.0 171.0 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - PROCESS | 32361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.89 (2.7%) stddev-sans-first:1.20 19:15:51 INFO - PROCESS | 32361 | Values: 74.0 71.0 71.0 70.0 69.0 69.0 68.0 69.0 68.0 68.0 19:15:51 INFO - PROCESS | 32361 | -------- Summary: end -------- 19:15:51 INFO - PROCESS | 32361 | 19:15:51 INFO - TEST-INFO | 32361: exit 0 19:15:51 INFO - TEST-OK | kraken | took 61162ms 19:15:51 INFO - SUITE-END | took 1172s 19:15:52 INFO - Completed test suite (00:19:32) 19:15:52 INFO - javascript benchmark 19:15:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.95410068849, 3097.4424603571347, 3126.968730312696, 3127.437061328961, 3161.446746819306, 5186.974065129679, 5203.817866374678, 5216.921746173811, 5256.0, 5274.340707411574, 5193.688378697271, 5205.0, 5209.453007434212, 5232.215167724843, 5259.13224317988, 4609.193391156543, 4644.233701439259, 4647.88380290492, 4697.765111744399, 4884.755762211875, 4789.832355867546, 4841.24960631101, 4856.101621200071, 4856.150173719602, 4871.512848715118, 4698.577128058491, 4709.576138147566, 4730.195866702668, 4754.500777418373, 4810.6151507879285, 4771.785269662873, 4784.282357646346, 4784.976075119602, 4789.233722604366, 4823.589994850442, 4632.513586073481, 4766.880827979294, 4774.40319960005, 4776.689515181502, 4821.614270858323, 5156.278121063054, 5179.171332586768, 5187.325647665779, 5214.139666954948, 5214.687118772886, 5550.4449555044575, 5569.610127291091, 5593.0, 5594.412586678381, 5595.524380427628, 5554.2779438673115, 5595.860103497404, 5619.438056194389, 5634.154876768476, 5635.633683810539, 5250.684958902478, 5268.0, 5271.28837606922, 5282.894342113174, 5319.574434045306, 5708.257926469615, 5721.57088218377, 5721.77112915487, 5727.541796656257, 5778.27771528559, 5375.0, 5479.589030822704, 5487.725613719298, 5491.2312276281355, 5495.203195536705, 5602.831915042555, 5604.551635869121, 5610.943890561042, 5612.466815652507, 5654.038813401731, 5574.052411090043, 5579.414161513064, 5588.21764952907, 5589.944100559023, 5592.0, 5422.0, 5519.199716041152, 5573.247611572386, 5581.665100094007, 5585.469380408855, 4269.914601707948, 4275.593818587229, 4279.422277992493, 4309.116631090619, 4318.41701370311, 3822.0827001519433, 3839.7696138231795, 3843.106180665588, 3864.8260828262796, 3871.9932817467097, 5187.403448603383, 5199.558037566773, 5267.841964741064, 5298.470152984671, 5356.303680521585, 5559.193916882029, 5575.609707320448, 5576.581756368208, 5578.135389014709, 5620.9437905621235, 5266.420693723688, 5287.312649355559, 5287.789885442886, 5294.285271488377, 5331.81338653153, 4723.197056500403, 4803.159447096744, 4846.8788280292565, 4891.510848915151, 4897.583705385082, 5813.680247586339, 5826.533877289807, 5830.3586605473365, 5835.649861008353, 5843.5909486336395, 5616.213730077874, 5628.662280263197, 5629.155626656035, 5629.746661400165, 5633.0987042073075, 5656.6888821115235, 5734.942650573441, 5790.478856902899, 5826.067829147316, 5826.475617194473, 5479.6164268500825, 5484.314460692413, 5488.753006114654, 5493.258410114583, 5500.312460942382, 5476.096444086681, 5568.136938774496, 5577.051901176891, 5578.693171875586, 5625.381208067028, 5461.290032295776, 5507.917381239365, 5520.585956053393, 5529.253550770594, 5571.05292100352, 5419.024575576276, 5436.266104076058, 5440.401555828935, 5440.836774896759, 5442.0748472760515, 5264.473552644705, 5289.761960711854, 5325.547328477122, 5372.086745253238, 5378.273933019149, 5448.101063324507, 5506.091494903296, 5515.448455154453, 5524.198991146181, 5576.0, 5374.220737992891, 5402.891942161214, 5403.216533602685, 5406.135018397038, 5438.8368348948015], "value": 5161.542864372016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4874382403045, 626.7618305044083, 627.5262177056322, 648.5751832549679, 649.8830210562097, 30485.39029219417, 37645.81177094114, 38693.80653096738, 38798.806005969964, 38802.22395552087, 40413.393799093035, 41200.38199427011, 41226.175476490454, 41258.79370603143, 41288.17423651525, 7627.5042122261875, 8463.407561470684, 8651.48091114532, 8673.566321683922, 9869.259805514579, 10023.899761002369, 10215.029572190668, 10228.181745460382, 10229.181665466745, 10248.026437488426, 10052.14556762676, 10294.536745846455, 10301.845472317922, 10305.433201173932, 10310.536025878853, 7483.812904677372, 7676.040494938133, 7677.50096243748, 10013.299069065168, 10021.498925053755, 10147.695569132939, 10302.124319432858, 10319.535620897077, 10323.793524129474, 10325.070743633034, 41575.37636935448, 42471.57528424707, 42476.57523424788, 42509.78745106285, 42511.0, 3375.578052743407, 3465.8960231193105, 3578.8926332210076, 3635.563732352108, 3658.359787037258, 32323.35353292921, 32363.19092022718, 32471.51292730611, 33135.502967455504, 34327.485087723704, 3693.593704692482, 3696.5933747287777, 3707.2029513654693, 3728.925421491555, 3744.101415660222, 311855.0, 313329.0, 313610.0, 313768.0, 314126.0, 54105.45894541004, 55373.72313138489, 55650.16524752132, 55702.0, 55710.72144639332, 54697.72651136798, 56149.0, 56305.71847140738, 56306.43693563094, 56420.43579564234, 16617.252223649964, 16866.409675661293, 16935.576610584587, 16946.15269236558, 16951.40670076566, 12900.35498225085, 12967.740645187043, 12977.805332920014, 12979.0, 12979.740405191844, 18950.336738214373, 19828.09736166809, 19847.801521984886, 19906.800931990783, 19970.400887973385, 7180.964095179491, 7343.080136308686, 7349.448791340671, 7385.778426647209, 7617.390608751287, 961.1205746741792, 966.6471737815647, 986.6990567876867, 1146.6158836789602, 1209.25026483579, 31723.84138079295, 32354.35291294161, 32683.509747353808, 33115.92720304613, 33166.33667326688, 1076.9407682577378, 1092.7705181911729, 1110.5446766825562, 1116.0569318925495, 1135.4095870147478, 16341.0, 16654.12465924781, 16897.831021689624, 16932.32270709158, 17005.0, 489169.0, 492268.0, 496141.0, 496523.0, 497534.0, 55834.0, 56604.0, 56658.0, 56697.43302566921, 56712.14931776027, 1322.134002228542, 1376.8416632087437, 1399.4472183487464, 1402.614281072713, 1404.9789253161211, 30198.69801302047, 30880.845595772775, 31742.0, 31914.0, 32236.0, 48276.27585586149, 49390.75304623598, 49560.256596150364, 49568.504314956386, 49589.0, 312277.0, 317391.0, 318932.0, 318995.0, 319104.0, 32833.35833208378, 36988.6301136996, 37812.81093594514, 40055.0, 40904.59095409127, 42454.15091698087, 42471.150576988905, 42811.7859410701, 42883.7855810719, 43598.12803743971, 35594.28811423705, 36119.638803611626, 36234.63765362418, 36738.26523469569, 37165.25669486541, 35281.82359088188, 38246.0, 39166.608333916294, 39874.60125398825, 40117.79941100393, 40304.59695403126, 40350.39474407945, 40676.38985415162, 40686.1862762749, 40850.38724419195, 32606.83696581502, 34088.318233635684, 34235.31529369448, 34409.0, 34747.30505389928, 26308.868455658365, 26689.105085488107, 26752.33119172036, 26898.59652105259, 26943.0], "value": 19748.39272942294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3004496389413, 369.15095280854035, 370.27056698304347, 383.83303263080546, 399.3291270665285, 18558.72161917572, 18633.460287233203, 19394.22423103076, 19484.318048868292, 19557.217711291567, 16401.507954761346, 16512.50462486124, 16562.254698538563, 17108.657826843457, 17151.0, 5546.584006199541, 5655.943440565604, 5659.688717120557, 5684.062129748587, 5701.885962280752, 3967.424723415103, 4044.3326851069687, 5816.854578635525, 6302.62184268943, 6321.7471301148125, 6082.482988945945, 6207.937920620804, 6211.0372892201785, 6214.596051256676, 6242.344553821851, 6069.241344831896, 6197.87604247917, 6200.410960958701, 6210.96894515529, 6211.0, 5411.053065713484, 5485.561155107622, 5487.176923461513, 5489.560835133179, 5579.9163012554845, 19616.313429029917, 19907.303244386523, 21957.121715131536, 22022.0, 22254.0, 2275.2264230161823, 2343.250159948817, 2474.9144022008013, 2626.2252635472582, 2667.546517092099, 13852.653683657889, 13876.722465550632, 14121.152730836182, 14193.219372934485, 14517.927410362987, 1945.5622484940916, 1958.5789055353025, 1979.604079184169, 2052.938411847647, 2069.617120832636, 77939.0, 78828.0, 79846.2498440035, 80446.0, 82065.58967205185, 9781.364211326241, 9953.402795832273, 10383.68848934518, 10437.538744575766, 10561.260711750258, 14211.289435528182, 14253.50112746049, 14272.500462483764, 14286.142831430148, 14311.856881431053, 7634.580098094658, 8175.95912020448, 8317.41778075529, 8354.331653467709, 8385.203405676451, 7963.8805417918775, 8065.314448271963, 8079.636416361161, 8226.218509241613, 8240.752777416687, 6389.9680501597195, 6408.6475243861105, 6489.5781774184525, 6496.935030649633, 6542.54202205841, 1761.4979730776668, 1801.5856353038876, 1819.2268285978407, 1838.724191371305, 1845.9261629534938, 918.2837386838277, 983.5229913491951, 1018.1294992781066, 1031.9793604127876, 1052.7841792432532, 18347.724784128248, 18425.53936151607, 19045.428637140907, 19073.332433364765, 19299.903500482407, 971.3686104032295, 983.8032393521324, 990.6136606723384, 1014.3356101753363, 1050.8528805967171, 10453.21600879937, 10786.083182929382, 10834.133269338434, 10944.17918656104, 10944.781104377867, 174964.0, 177432.0, 177810.0, 179107.0, 476153.0, 52596.73701631468, 76431.61784191044, 79397.60301198573, 80837.59581202056, 81157.18842811615, 1015.1574193419444, 1017.8982101789762, 1036.124474818777, 1040.9011143941314, 1071.887451817548, 16275.104869232306, 16761.91619041946, 16888.831111688727, 16950.321987120376, 17259.0, 30408.543871842383, 32204.355912881143, 36345.81827090848, 37407.251854963295, 38395.80802095972, 48056.0, 49124.50875491199, 49906.0, 51203.231951520014, 51588.22617660663, 8178.0, 8280.296174825207, 8377.685298625514, 8548.23065924045, 8651.875256216652, 13276.933615331862, 13557.728845423233, 13631.454741810216, 13794.241316727275, 13797.724045518833, 11378.361675405182, 11446.255993360404, 11609.013233875216, 12024.398780060787, 12088.576899808464, 11464.541418343506, 11498.655040348804, 11697.473613687574, 11773.117016223647, 12125.393730313273, 11489.0, 11689.473973671375, 11903.0, 11917.165798394375, 12432.689182770504, 8226.30076443509, 8338.29124524398, 8366.916330836613, 8535.615897284513, 8591.742247732578, 12108.51565937388, 12162.331071791137, 12192.878071219175, 12200.450979705756, 12269.386530673251], "value": 8986.582995413466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.9009324300669, 1501.0, 1514.939402423903, 1667.4330727552629, 1797.8202179782015, 7127.10911136108, 7810.062792464898, 7990.920090799097, 8017.959910200456, 8018.799530011753, 7803.921960780391, 7930.206979302067, 7934.682612695499, 7948.523088614673, 7952.244536768998, 1966.2823069579572, 2176.379731776444, 2178.6078505868936, 2203.823694104468, 2253.583087128878, 2207.5253820428607, 2236.39617303328, 2239.0484044281197, 2239.0595949701164, 2244.0574958517464, 2129.9893500532476, 2183.1049269799387, 2189.4635814225535, 2190.123950419829, 2190.145843121184, 1938.176275083084, 2152.9031193596247, 2215.2135991722866, 2216.5899308627954, 2220.655798351242, 2085.9165633374646, 2095.0, 2103.9368818935454, 2107.4099252209253, 2162.9783702162936, 8017.198280171994, 8043.235892590194, 8115.229053239933, 8119.95940020302, 8129.146439623813, 4732.077244937239, 4912.557869791736, 4919.975400123012, 4923.138450771136, 4923.163062279421, 3011.8795248190045, 3048.4360393327083, 3068.70847269509, 3156.8737250509953, 3179.0621766578683, 1002.3685078400633, 1017.9898201017969, 1026.8049070676623, 1027.7995790820794, 1035.5081336365242, 10922.726931826688, 11089.55641774328, 11095.167862410352, 11107.72230694239, 11122.054625356854, 4264.744115353089, 4411.558844115627, 4417.425734654475, 4417.469903611523, 4475.060237350193, 9533.0, 9553.283503737248, 9566.808663826685, 9590.376625519319, 9612.855807162898, 4422.889427764331, 4959.70241785494, 4971.477994810565, 5006.224035274538, 5011.1481048221885, 4478.484974228006, 4630.120277147331, 4641.8375356863025, 4647.697899636512, 4654.2785868190485, 3708.9072773180346, 3732.3841566141828, 3798.6581207691443, 3802.771833689932, 3860.613938606173, 1174.5654107980101, 1193.2005556277315, 1200.6458094862037, 1201.9819702704467, 1202.4588934979295, 902.697596305232, 988.619381538113, 989.9703008909744, 1015.9136473399844, 1027.0397178637998, 5736.827895163152, 5746.655200687972, 5747.942520574825, 5826.271716035496, 5873.2658417697785, 412.71316435077335, 424.5733038296492, 425.28552032585554, 427.7658953917907, 429.8151794728297, 3813.103920578662, 3854.383298672199, 3859.0, 3883.37865941448, 3926.86255981045, 9537.14165725088, 9797.706068817946, 10005.49972501372, 10018.74953126163, 10106.797864042677, 9791.412515249107, 9932.056454636799, 9993.300468967247, 9999.300048996645, 10017.148542373834, 7268.890966635505, 7591.962040189764, 7592.013038304985, 7666.543356762309, 7677.961610192025, 5673.0, 5705.486506214461, 5782.219400381063, 5809.912851307149, 5905.704714764331, 8810.823783524422, 8814.867776983223, 8884.0, 8968.834051573254, 8990.775230619287, 8861.424007439497, 9084.454932704059, 9086.90913090887, 9183.448993060438, 9322.720318390458, 6372.394622510854, 6589.835254118685, 6605.900911486236, 6930.44556435494, 7035.472339574655, 7271.890921636285, 7387.556746595222, 7463.2163622818825, 7469.215732348025, 7492.925070749223, 6678.7328506859185, 6823.624700641512, 6858.588484690935, 7049.718011279697, 7145.821354465972, 6936.965315173594, 6954.0, 6973.267806880204, 7025.367716905503, 7045.964770176116, 6347.873042539031, 6369.522285828489, 6443.67781610927, 6475.449586784987, 6477.708503117276, 4738.455077665974, 4792.137415265286, 4795.448523419851, 4865.537773911473, 4885.682430641997, 4640.791164397678, 4855.441624213261, 4902.2156454967035, 4927.260910863256, 5022.623303252198], "value": 4217.888302192873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.37050619963577, 303.76761777240415, 304.09531643361, 307.09866541700126, 309.78934324659224, 5227.424983251839, 5275.868103297415, 5296.417394086657, 5332.866678333039, 5364.746806341336, 5183.766730497127, 5235.79056837727, 5279.208118782185, 5286.629935904488, 5320.9467905320935, 3861.517310336208, 3928.8428462861452, 3933.4296527003567, 3977.806658002602, 4001.8999525011964, 3922.2155568886196, 4061.7002559181074, 4073.775942323171, 4076.429299898017, 4080.2451546464, 3975.0, 4015.738976966488, 4029.597040295976, 4037.4347591337237, 4042.454268673721, 3829.4064420014943, 3998.6801055915603, 4024.9798751006056, 4026.8590599329177, 4042.7776472294013, 3482.6343233960574, 3488.2674638325984, 3506.3162683276773, 3515.876944306937, 3526.7002304804123, 5083.923741143886, 5123.436421993578, 5126.6667666601925, 5140.1518749406305, 5155.922661160085, 4485.282354823213, 4516.525764794715, 4563.908721825578, 4587.220172570637, 4615.538446155391, 5453.645513041679, 5483.232347471358, 5490.80782172626, 5495.6153069285165, 5510.476504732084, 3790.7346485746007, 3792.1846802937225, 3810.295095407331, 3811.1805961718087, 3818.083659921627, 5427.565794736412, 5624.803131890405, 5791.797287094973, 5801.796937107181, 5803.53571714266, 3822.369309063973, 3827.483289755903, 3845.7503409619385, 3867.207222519377, 3879.8060096995036, 3880.165764360676, 3887.669548088444, 3893.669038131734, 3896.3960586109197, 3909.7458665186673, 4538.659600529907, 4543.727376357429, 4563.703359281636, 4573.839915602938, 4579.80924959513, 5260.868478288074, 5528.640638358494, 5541.251930989265, 5578.9163162552595, 5605.243292155506, 1424.8432672406027, 1425.8431572527013, 1427.7929700193413, 1433.5555977646964, 1433.7705967045222, 889.2574700125467, 920.2775820980498, 942.0861764088822, 954.8997355277735, 957.6360982826482, 5075.289459475676, 5276.604254680914, 5305.0, 5577.776888924398, 5586.608937374426, 5599.832005039855, 5645.23789288449, 5698.6580805151825, 5725.828225153252, 5784.2769653793275, 5412.890357476708, 5419.485148910847, 5460.972695136578, 5461.672299662033, 5501.14732216507, 3125.0624812556143, 3214.7428205743486, 3280.950785738216, 3281.6882396172327, 3306.487494438366, 6331.588446750947, 6345.333739957238, 6346.619202847752, 6350.364963503705, 6353.237611486558, 6004.579679422399, 6233.937660623426, 6301.558890877594, 6309.716062777186, 6353.36466353361, 6334.746610135635, 6343.207099112611, 6351.587146835441, 6384.776532821329, 6443.6455994920725, 5504.614676972574, 6124.724387402489, 6162.198914141133, 6170.50635949114, 6183.938160618516, 5635.802746903839, 5650.29371328584, 5650.519705824887, 5671.950689122526, 5681.147827825859, 5928.733207005781, 5929.9110513341475, 5998.460138587374, 5998.49012833914, 6003.459688628044, 3731.869384571527, 3955.426463162883, 3963.4847469828737, 3964.8017599119353, 3987.1826275614007, 5727.369989301257, 5741.8564535886935, 5742.28221472316, 5750.6837123958585, 5760.711964401679, 5589.916151257653, 5599.524040456607, 5614.6631202128, 5639.295088113986, 5649.491545760901, 5509.3664228614225, 5533.529649979797, 5547.195656629847, 5577.27495425592, 5591.30108736408, 5203.713795741119, 5327.893442131213, 5487.259220005249, 5496.532794712494, 5535.7785688572, 5615.848751005952, 5632.183333416549, 5640.54875609942, 5654.519365853948, 5657.405972373006, 5239.109351410193, 5480.534154596904, 5495.890082198413, 5500.972495137658, 5519.227308176778], "value": 4226.841689099658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8664553734786, 740.8666440040794, 742.2540346951313, 757.3865169212938, 776.6815605601704, 14647.633809154762, 15054.548363549084, 15067.095974241553, 15124.092554446726, 15136.545903622895, 13022.934885325583, 13053.151545149558, 13082.607521774362, 13084.803727944065, 13088.73822523549, 648.8767134244503, 765.2003656179306, 795.3557618329157, 799.7560743973086, 812.524673066254, 796.0487217774762, 799.9280064794167, 803.8794180872858, 806.0569134113101, 807.3944541593804, 849.8385306791721, 849.9830003399928, 851.1190917400461, 851.9148085191493, 852.3735054734765, 683.4907993544816, 706.7597017014214, 709.0498731699496, 825.471698113208, 844.7676888855552, 622.2874808344466, 624.3912185618985, 627.6767464755654, 628.6071205496564, 630.1461519640867, 13772.173669579857, 13805.0, 13834.654133646638, 13836.930815345959, 13845.515406960809, 12426.813597796041, 13180.143290686075, 13549.932250338685, 13679.0, 13695.657608559766, 11222.046126079293, 11261.943690281578, 11387.25982811123, 11453.713657158554, 11456.4844581994, 3712.443133529965, 3783.9432408513894, 3798.6391292827416, 3800.3349413852743, 3845.8461661533506, 50759.49240507621, 51474.0, 51516.0, 51521.48478515242, 51537.484625153644, 9386.202172815387, 9439.528023598792, 9726.925068716931, 9768.560414781352, 9952.353097048668, 16295.0, 16350.75473867893, 16353.836461635232, 16373.67252654964, 16467.34130634785, 7376.594287314249, 7387.519811212362, 7424.331810137113, 7478.4765066444825, 7640.770776876702, 4495.57292057254, 4519.276915693474, 4526.140033393644, 4590.0, 4670.602998745077, 3256.5603643507825, 3301.356235534096, 3317.104381816896, 3327.966720332766, 3329.517220003086, 563.4984863471514, 568.1903287814847, 571.4628249445508, 579.9681017543991, 594.5867622002753, 692.8995295682199, 730.6711979609197, 740.8777551703909, 754.5585832288173, 756.2324240895496, 8361.874571881426, 8724.214820666171, 8825.205731484197, 8852.583207902704, 8911.55442227886, 737.3879679865698, 740.9073865766779, 744.3858816476428, 745.3813334931993, 767.3592550220517, 4184.937225941613, 4192.685548583808, 4235.23765722173, 4255.914881702411, 4267.701260911706, 57905.0, 58850.11724824131, 59374.0, 60442.39557604455, 60728.0, 51211.0, 51483.74258128685, 51717.0, 52085.0, 55249.44750552523, 47742.04515909732, 47984.0, 48852.02295954061, 48975.51024489781, 49400.25899611509, 8290.37822163328, 8441.535715535705, 8502.277306428776, 8581.0560838309, 9066.637334506546, 32163.356732864744, 33138.0, 33697.83151084229, 34026.0, 34506.89437950597, 43139.0, 43751.12497749963, 43986.78006609946, 44180.779096104314, 44942.0, 11069.391183484986, 11113.499892504695, 11653.53385864556, 11873.346965916957, 11877.881221187678, 12263.141580089308, 12273.509059637514, 12289.201201921847, 12324.50701971911, 12504.062195335204, 9776.706698799047, 11042.392668403316, 11843.822342665038, 11873.643790686294, 11901.642950711492, 10769.407682577534, 10824.5128969195, 10832.295900766425, 11165.88834111681, 11182.944085279521, 11411.315321080761, 11793.941030294794, 11933.761324773282, 11965.880341196476, 12114.333711645944, 10159.390436573829, 10289.022542858416, 10313.639022634172, 10316.638917637847, 10617.1506279499, 9909.398080315681, 10156.644517441853, 10391.48042597852, 10587.417692027013, 10673.199510036624], "value": 6437.940228152157, "unit": "score"}], "name": "dromaeo_css", "value": 6870.189267686375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 107.0, 111.0, 111.0, 112.0, 100.0, 112.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 160.0, 188.0, 130.0, 155.0, 154.0, 129.0, 189.0, 127.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 106.0, 117.0, 77.0, 72.0, 74.0, 129.0, 105.0, 74.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 91.0, 93.0, 94.0, 158.0, 92.0, 92.0, 144.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 59.0, 58.0, 62.0, 59.0, 77.0, 58.0, 59.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 75.0, 77.0, 77.0, 79.0, 79.0, 78.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 125.0, 132.0, 125.0, 127.0, 122.0, 122.0, 122.0, 160.0, 127.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 169.0, 172.0, 173.0, 175.0, 168.0, 170.0, 179.0, 171.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 71.0, 70.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1550.6000000000001, "alertThreshold": 2.0}]} 19:15:52 INFO - Return code: 0 19:15:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:15:52 ERROR - # TBPL SUCCESS # 19:15:52 INFO - Running post-action listener: _resource_record_post_action 19:15:52 INFO - Running post-run listener: _resource_record_post_run 19:15:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535212032; Read time: 8; Write time: 465932 19:15:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244654080; Read time: 0; Write time: 283588 19:15:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290557952; Read time: 8; Write time: 182344 19:15:53 INFO - Running post-run listener: _upload_blobber_files 19:15:53 INFO - Blob upload gear active. 19:15:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:15:53 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 19:15:53 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:15:53 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:15:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:15:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:15:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:15:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:54 INFO - (blobuploader) - INFO - Done attempting. 19:15:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:15:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:15:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:15:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:15:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:15:55 INFO - (blobuploader) - INFO - Done attempting. 19:15:55 INFO - (blobuploader) - INFO - Iteration through files over. 19:15:55 INFO - Return code: 0 19:15:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:15:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:15:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcee90fe2cf80ed64596206a7b478c07f2e543f7f31bded0f654f43761c1efe8ea109adc1090a6c54c47ce19a878277c678e6b78db649e3156c08b1974ae1b19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13ddd0566663290cc222efad5d42834f563073eee8bda36b3f73bf69d85e80d1f70dd9628a981e954ba6d97dda0d59bc2cbc7ec945b67187b80a837e147a3e52"} 19:15:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:15:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:15:55 INFO - Contents: 19:15:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcee90fe2cf80ed64596206a7b478c07f2e543f7f31bded0f654f43761c1efe8ea109adc1090a6c54c47ce19a878277c678e6b78db649e3156c08b1974ae1b19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13ddd0566663290cc222efad5d42834f563073eee8bda36b3f73bf69d85e80d1f70dd9628a981e954ba6d97dda0d59bc2cbc7ec945b67187b80a837e147a3e52"} 19:15:55 INFO - Running post-run listener: copy_logs_to_upload_dir 19:15:55 INFO - Copying logs to upload dir... 19:15:55 INFO - mkdir: /builds/slave/test/build/upload/logs 19:15:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.164197 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-22 19:15:55.376691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 19:15:55.380729) ========= 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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcee90fe2cf80ed64596206a7b478c07f2e543f7f31bded0f654f43761c1efe8ea109adc1090a6c54c47ce19a878277c678e6b78db649e3156c08b1974ae1b19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13ddd0566663290cc222efad5d42834f563073eee8bda36b3f73bf69d85e80d1f70dd9628a981e954ba6d97dda0d59bc2cbc7ec945b67187b80a837e147a3e52"} build_url:https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcee90fe2cf80ed64596206a7b478c07f2e543f7f31bded0f654f43761c1efe8ea109adc1090a6c54c47ce19a878277c678e6b78db649e3156c08b1974ae1b19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13ddd0566663290cc222efad5d42834f563073eee8bda36b3f73bf69d85e80d1f70dd9628a981e954ba6d97dda0d59bc2cbc7ec945b67187b80a837e147a3e52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 19:15:55.406134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 19:15:55.406469) ========= 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=00204705a9daa57ed339a427000001b9-1461369727.204611-1321292596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 19:15:55.490490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 19:15:55.490828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 19:15:55.491169) ========= ========= Total master_lag: 0.18 =========