builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1461982885.88 results: success (0) buildid: 20160429164537 builduid: 53a89d8735f0429799062611998c5db8 revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.878366) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.878889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.879176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.895898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.896229) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 19:21:26-- 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% 42.5M=0s 2016-04-29 19:21:26 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.988470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:25.988802) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:26.037935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 19:21:26.038340) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 19:21:26,326 truncating revision to first 12 chars 2016-04-29 19:21:26,326 Setting DEBUG logging. 2016-04-29 19:21:26,326 attempt 1/10 2016-04-29 19:21:26,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1347c189b6da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 19:21:27,727 unpacking tar archive at: mozilla-aurora-1347c189b6da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.682991 ========= master_lag: 0.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 19:21:28.648606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:28.648868) ========= script_repo_revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:28.649239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:28.649509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 19:21:28.679261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 19:21:28.679579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:29 INFO - MultiFileLogger online at 20160429 19:21:29 in /builds/slave/test 19:21:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:21:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:29 INFO - {'append_to_log': False, 19:21:29 INFO - 'base_work_dir': '/builds/slave/test', 19:21:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:21:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:29 INFO - 'branch': 'Mozilla-Aurora', 19:21:29 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:29 INFO - 'config_files': ('talos/linux_config.py',), 19:21:29 INFO - 'default_actions': ('clobber', 19:21:29 INFO - 'read-buildbot-config', 19:21:29 INFO - 'download-and-extract', 19:21:29 INFO - 'populate-webroot', 19:21:29 INFO - 'create-virtualenv', 19:21:29 INFO - 'install', 19:21:29 INFO - 'run-tests'), 19:21:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:29 INFO - 'download_minidump_stackwalk': True, 19:21:29 INFO - 'download_symbols': 'ondemand', 19:21:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:29 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:29 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:29 INFO - 'installer_path': 'installer.exe', 19:21:29 INFO - 'log_level': 'info', 19:21:29 INFO - 'log_name': 'talos', 19:21:29 INFO - 'log_to_console': True, 19:21:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:29 INFO - 'opt_config_files': (), 19:21:29 INFO - 'pip_index': False, 19:21:29 INFO - 'sps_profile': False, 19:21:29 INFO - 'sps_profile_interval': 0, 19:21:29 INFO - 'suite': 'dromaeojs-e10s', 19:21:29 INFO - 'system_bits': '32', 19:21:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:29 INFO - 'title': 'talos-linux64-ix-005', 19:21:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:29 INFO - 'use_talos_json': True, 19:21:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:29 INFO - 'work_dir': 'build'} 19:21:29 INFO - ##### 19:21:29 INFO - ##### Running clobber step. 19:21:29 INFO - ##### 19:21:29 INFO - Running pre-action listener: _resource_record_pre_action 19:21:29 INFO - Running main action method: clobber 19:21:29 INFO - rmtree: /builds/slave/test/build 19:21:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:29 INFO - Running post-action listener: _resource_record_post_action 19:21:29 INFO - ##### 19:21:29 INFO - ##### Running read-buildbot-config step. 19:21:29 INFO - ##### 19:21:29 INFO - Running pre-action listener: _resource_record_pre_action 19:21:29 INFO - Running main action method: read_buildbot_config 19:21:29 INFO - Using buildbot properties: 19:21:29 INFO - { 19:21:29 INFO - "project": "", 19:21:29 INFO - "product": "firefox", 19:21:29 INFO - "script_repo_revision": "production", 19:21:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:21:29 INFO - "repository": "", 19:21:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:21:29 INFO - "buildid": "20160429164537", 19:21:29 INFO - "pgo_build": "True", 19:21:29 INFO - "basedir": "/builds/slave/test", 19:21:29 INFO - "buildnumber": 270, 19:21:29 INFO - "slavename": "talos-linux64-ix-005", 19:21:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:21:29 INFO - "platform": "ubuntu64_hw", 19:21:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:21:29 INFO - "branch": "mozilla-aurora", 19:21:29 INFO - "repo_path": "releases/mozilla-aurora", 19:21:29 INFO - "revision": "1347c189b6da67d2142fb266c82f74272b09139b", 19:21:29 INFO - "stage_platform": "linux64-pgo", 19:21:29 INFO - "builduid": "53a89d8735f0429799062611998c5db8", 19:21:29 INFO - "slavebuilddir": "test" 19:21:29 INFO - } 19:21:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:21:29 INFO - Running post-action listener: _resource_record_post_action 19:21:29 INFO - ##### 19:21:29 INFO - ##### Running download-and-extract step. 19:21:29 INFO - ##### 19:21:29 INFO - Running pre-action listener: _resource_record_pre_action 19:21:29 INFO - Running main action method: download_and_extract 19:21:29 INFO - mkdir: /builds/slave/test/build/tests 19:21: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')]} 19:21:29 INFO - https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:21:39 INFO - Downloaded 1361 bytes. 19:21:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:21:39 INFO - Using the following test package requirements: 19:21:39 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:21:39 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:21:39 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:21:39 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'jsshell-linux-x86_64.zip'], 19:21:39 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:21:39 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:21:39 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:21:39 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:21:39 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:21:39 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:21:39 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:21:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:21: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')]} 19:21:39 INFO - https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:44 INFO - Downloaded 23820982 bytes. 19:21:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:45 INFO - Return code: 0 19:21:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:21: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')]} 19:21:45 INFO - https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:54 INFO - Downloaded 23820982 bytes. 19:21:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:56 INFO - Return code: 0 19:21:56 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')]} 19:21:56 INFO - https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:21:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:21:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:21:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:21:58 INFO - Downloaded 10840145 bytes. 19:21:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:21:58 INFO - Return code: 0 19:21: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')]} 19:21:58 INFO - https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:22:00 INFO - Downloaded 62690893 bytes. 19:22:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:22:00 INFO - mkdir: /builds/slave/test/properties 19:22:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:22:00 INFO - Writing to file /builds/slave/test/properties/build_url 19:22:00 INFO - Contents: 19:22:00 INFO - build_url:https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:22:01 INFO - Running post-action listener: _resource_record_post_action 19:22:01 INFO - Running post-action listener: set_extra_try_arguments 19:22:01 INFO - ##### 19:22:01 INFO - ##### Running populate-webroot step. 19:22:01 INFO - ##### 19:22:01 INFO - Running pre-action listener: _resource_record_pre_action 19:22:01 INFO - Running main action method: populate_webroot 19:22:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:22:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:22:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:22:01 INFO - '--tppagecycles', 19:22:01 INFO - '7'], 19:22:01 INFO - 'tests': ['tsvgm']}}, 19:22:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:22:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:22:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:22:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:22:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:22:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['damp', 'tps']}, 19:22:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'tests': ['damp', 'tps']}, 19:22:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['dromaeo_dom']}, 19:22:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:22:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'other-e10s': {'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['a11yr', 19:22:01 INFO - 'ts_paint', 19:22:01 INFO - 'tpaint', 19:22:01 INFO - 'sessionrestore', 19:22:01 INFO - 'sessionrestore_no_auto_restore', 19:22:01 INFO - 'tabpaint']}, 19:22:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['tsvgx', 19:22:01 INFO - 'tsvgr_opacity', 19:22:01 INFO - 'tart', 19:22:01 INFO - 'tscrollx', 19:22:01 INFO - 'cart']}, 19:22:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:22:01 INFO - 'tsvgr_opacity', 19:22:01 INFO - 'tart', 19:22:01 INFO - 'tscrollx', 19:22:01 INFO - 'cart']}, 19:22:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'talos_options': ['--disable-e10s'], 19:22:01 INFO - 'tests': ['tp5o']}, 19:22:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'tests': ['tp5o']}, 19:22:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'talos_options': ['--disable-e10s', 19:22:01 INFO - '--xperf_path', 19:22:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:01 INFO - 'tests': ['tp5n']}, 19:22:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:22:01 INFO - 'talos_options': ['--xperf_path', 19:22:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:22:01 INFO - 'tests': ['tp5n']}}, 19:22:01 INFO - 'talos.zip': {'path': '', 19:22:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:22:01 INFO - Running post-action listener: _resource_record_post_action 19:22:01 INFO - ##### 19:22:01 INFO - ##### Running create-virtualenv step. 19:22:01 INFO - ##### 19:22:01 INFO - Running pre-action listener: _resource_record_pre_action 19:22:01 INFO - Running main action method: create_virtualenv 19:22:01 INFO - Creating virtualenv /builds/slave/test/build/venv 19:22:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:22:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:22:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:22:01 INFO - Using real prefix '/usr' 19:22:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:22:01 INFO - Installing distribute.............................................................................................................................................................................................done. 19:22:03 INFO - Installing pip.................done. 19:22:03 INFO - Return code: 0 19:22:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:22:03 INFO - Using env: {'DISPLAY': ':0', 19:22:03 INFO - 'HOME': '/home/cltbld', 19:22:03 INFO - 'LANG': 'en_US.UTF-8', 19:22:03 INFO - 'LANGUAGE': 'en_US:en', 19:22:03 INFO - 'LOGNAME': 'cltbld', 19:22:03 INFO - 'MAIL': '/var/mail/cltbld', 19:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:03 INFO - 'MOZ_NO_REMOTE': '1', 19:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:03 INFO - 'NO_EM_RESTART': '1', 19:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:03 INFO - 'PWD': '/builds/slave/test', 19:22:03 INFO - 'SHELL': '/bin/bash', 19:22:03 INFO - 'SHLVL': '1', 19:22:03 INFO - 'TERM': 'linux', 19:22:03 INFO - 'TMOUT': '86400', 19:22:03 INFO - 'USER': 'cltbld', 19:22:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:03 INFO - '_': '/tools/buildbot/bin/python'} 19:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:22:04 INFO - Cleaning up... 19:22:04 INFO - Return code: 0 19:22:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:22:04 INFO - Using env: {'DISPLAY': ':0', 19:22:04 INFO - 'HOME': '/home/cltbld', 19:22:04 INFO - 'LANG': 'en_US.UTF-8', 19:22:04 INFO - 'LANGUAGE': 'en_US:en', 19:22:04 INFO - 'LOGNAME': 'cltbld', 19:22:04 INFO - 'MAIL': '/var/mail/cltbld', 19:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:04 INFO - 'MOZ_NO_REMOTE': '1', 19:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:04 INFO - 'NO_EM_RESTART': '1', 19:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:04 INFO - 'PWD': '/builds/slave/test', 19:22:04 INFO - 'SHELL': '/bin/bash', 19:22:04 INFO - 'SHLVL': '1', 19:22:04 INFO - 'TERM': 'linux', 19:22:04 INFO - 'TMOUT': '86400', 19:22:04 INFO - 'USER': 'cltbld', 19:22:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:04 INFO - '_': '/tools/buildbot/bin/python'} 19:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:04 INFO - Downloading/unpacking psutil>=0.7.1 19:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:06 INFO - Installing collected packages: psutil 19:22:06 INFO - Running setup.py install for psutil 19:22:06 INFO - building 'psutil._psutil_linux' extension 19:22:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:22:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:22:06 INFO - building 'psutil._psutil_posix' extension 19:22:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:22:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:22:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:06 INFO - Successfully installed psutil 19:22:06 INFO - Cleaning up... 19:22:06 INFO - Return code: 0 19:22:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:22:06 INFO - Using env: {'DISPLAY': ':0', 19:22:06 INFO - 'HOME': '/home/cltbld', 19:22:06 INFO - 'LANG': 'en_US.UTF-8', 19:22:06 INFO - 'LANGUAGE': 'en_US:en', 19:22:06 INFO - 'LOGNAME': 'cltbld', 19:22:06 INFO - 'MAIL': '/var/mail/cltbld', 19:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:06 INFO - 'MOZ_NO_REMOTE': '1', 19:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:06 INFO - 'NO_EM_RESTART': '1', 19:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:06 INFO - 'PWD': '/builds/slave/test', 19:22:06 INFO - 'SHELL': '/bin/bash', 19:22:06 INFO - 'SHLVL': '1', 19:22:06 INFO - 'TERM': 'linux', 19:22:06 INFO - 'TMOUT': '86400', 19:22:06 INFO - 'USER': 'cltbld', 19:22:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:06 INFO - '_': '/tools/buildbot/bin/python'} 19:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:22:09 INFO - Installing collected packages: mozsystemmonitor 19:22:09 INFO - Running setup.py install for mozsystemmonitor 19:22:09 INFO - Successfully installed mozsystemmonitor 19:22:09 INFO - Cleaning up... 19:22:09 INFO - Return code: 0 19:22:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:22:09 INFO - Using env: {'DISPLAY': ':0', 19:22:09 INFO - 'HOME': '/home/cltbld', 19:22:09 INFO - 'LANG': 'en_US.UTF-8', 19:22:09 INFO - 'LANGUAGE': 'en_US:en', 19:22:09 INFO - 'LOGNAME': 'cltbld', 19:22:09 INFO - 'MAIL': '/var/mail/cltbld', 19:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:09 INFO - 'MOZ_NO_REMOTE': '1', 19:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:09 INFO - 'NO_EM_RESTART': '1', 19:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:09 INFO - 'PWD': '/builds/slave/test', 19:22:09 INFO - 'SHELL': '/bin/bash', 19:22:09 INFO - 'SHLVL': '1', 19:22:09 INFO - 'TERM': 'linux', 19:22:09 INFO - 'TMOUT': '86400', 19:22:09 INFO - 'USER': 'cltbld', 19:22:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:09 INFO - '_': '/tools/buildbot/bin/python'} 19:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:09 INFO - Downloading/unpacking blobuploader==1.2.4 19:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:11 INFO - Downloading blobuploader-1.2.4.tar.gz 19:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:22:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:22:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:11 INFO - Downloading docopt-0.6.1.tar.gz 19:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:22:11 INFO - Installing collected packages: blobuploader, requests, docopt 19:22:11 INFO - Running setup.py install for blobuploader 19:22:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:22:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:22:12 INFO - Running setup.py install for requests 19:22:12 INFO - Running setup.py install for docopt 19:22:12 INFO - Successfully installed blobuploader requests docopt 19:22:12 INFO - Cleaning up... 19:22:12 INFO - Return code: 0 19:22:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:22:12 INFO - Using env: {'DISPLAY': ':0', 19:22:12 INFO - 'HOME': '/home/cltbld', 19:22:12 INFO - 'LANG': 'en_US.UTF-8', 19:22:12 INFO - 'LANGUAGE': 'en_US:en', 19:22:12 INFO - 'LOGNAME': 'cltbld', 19:22:12 INFO - 'MAIL': '/var/mail/cltbld', 19:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:12 INFO - 'MOZ_NO_REMOTE': '1', 19:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:12 INFO - 'NO_EM_RESTART': '1', 19:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:12 INFO - 'PWD': '/builds/slave/test', 19:22:12 INFO - 'SHELL': '/bin/bash', 19:22:12 INFO - 'SHLVL': '1', 19:22:12 INFO - 'TERM': 'linux', 19:22:12 INFO - 'TMOUT': '86400', 19:22:12 INFO - 'USER': 'cltbld', 19:22:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:12 INFO - '_': '/tools/buildbot/bin/python'} 19:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:12 INFO - Running setup.py (path:/tmp/pip-4b0tVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:12 INFO - Running setup.py (path:/tmp/pip-i_QZRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:12 INFO - Running setup.py (path:/tmp/pip-xwu5Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:13 INFO - Running setup.py (path:/tmp/pip-bw7hIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:13 INFO - Running setup.py (path:/tmp/pip-vcDlgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:13 INFO - Running setup.py (path:/tmp/pip-Zeadf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:13 INFO - Running setup.py (path:/tmp/pip-90Awes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:13 INFO - Running setup.py (path:/tmp/pip-0llrTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:13 INFO - Running setup.py (path:/tmp/pip-m9LGyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:13 INFO - Running setup.py (path:/tmp/pip-vcltCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:13 INFO - Running setup.py (path:/tmp/pip-3RO53Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:13 INFO - Running setup.py (path:/tmp/pip-f5FscG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:13 INFO - Running setup.py (path:/tmp/pip-7NZMn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:13 INFO - Running setup.py (path:/tmp/pip-4GjI_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:13 INFO - Running setup.py (path:/tmp/pip-zVQqnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:13 INFO - Running setup.py (path:/tmp/pip-NVDM2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:13 INFO - Running setup.py (path:/tmp/pip-3BWCZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:22:14 INFO - Running setup.py install for manifestparser 19:22:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Running setup.py install for mozcrash 19:22:14 INFO - Running setup.py install for mozdebug 19:22:14 INFO - Running setup.py install for mozdevice 19:22:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Running setup.py install for mozfile 19:22:14 INFO - Running setup.py install for mozhttpd 19:22:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Running setup.py install for mozinfo 19:22:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Running setup.py install for mozInstall 19:22:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:22:14 INFO - Running setup.py install for mozleak 19:22:14 INFO - Running setup.py install for mozlog 19:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Running setup.py install for moznetwork 19:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Running setup.py install for mozprocess 19:22:15 INFO - Running setup.py install for mozprofile 19:22:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Running setup.py install for mozrunner 19:22:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Running setup.py install for mozscreenshot 19:22:15 INFO - Running setup.py install for moztest 19:22:15 INFO - Running setup.py install for mozversion 19:22:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:22:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:22:15 INFO - Cleaning up... 19:22:15 INFO - Return code: 0 19:22:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:22:15 INFO - Using env: {'DISPLAY': ':0', 19:22:15 INFO - 'HOME': '/home/cltbld', 19:22:15 INFO - 'LANG': 'en_US.UTF-8', 19:22:15 INFO - 'LANGUAGE': 'en_US:en', 19:22:15 INFO - 'LOGNAME': 'cltbld', 19:22:15 INFO - 'MAIL': '/var/mail/cltbld', 19:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:15 INFO - 'MOZ_NO_REMOTE': '1', 19:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:15 INFO - 'NO_EM_RESTART': '1', 19:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:15 INFO - 'PWD': '/builds/slave/test', 19:22:15 INFO - 'SHELL': '/bin/bash', 19:22:15 INFO - 'SHLVL': '1', 19:22:15 INFO - 'TERM': 'linux', 19:22:15 INFO - 'TMOUT': '86400', 19:22:15 INFO - 'USER': 'cltbld', 19:22:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:15 INFO - '_': '/tools/buildbot/bin/python'} 19:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:16 INFO - Running setup.py (path:/tmp/pip-Aw86DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:16 INFO - Running setup.py (path:/tmp/pip-uCFBhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:16 INFO - Running setup.py (path:/tmp/pip-X4b4Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:16 INFO - Running setup.py (path:/tmp/pip-stGqvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:16 INFO - Running setup.py (path:/tmp/pip-amIYwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:16 INFO - Running setup.py (path:/tmp/pip-9walbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:16 INFO - Running setup.py (path:/tmp/pip-ngdVHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:16 INFO - Running setup.py (path:/tmp/pip-1JkkkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:16 INFO - Running setup.py (path:/tmp/pip-mqVIhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:16 INFO - Running setup.py (path:/tmp/pip-kmipxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:16 INFO - Running setup.py (path:/tmp/pip-rpsG1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:16 INFO - Running setup.py (path:/tmp/pip-Xrplb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:16 INFO - Running setup.py (path:/tmp/pip-PujoCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:16 INFO - Running setup.py (path:/tmp/pip-hwJh2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:17 INFO - Running setup.py (path:/tmp/pip-L6Rfw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:17 INFO - Running setup.py (path:/tmp/pip-DN54uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:17 INFO - Running setup.py (path:/tmp/pip-SGWPz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:19 INFO - Downloading blessings-1.6.tar.gz 19:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:22:19 INFO - Installing collected packages: blessings 19:22:19 INFO - Running setup.py install for blessings 19:22:19 INFO - Successfully installed blessings 19:22:19 INFO - Cleaning up... 19:22:19 INFO - Return code: 0 19:22:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:19 INFO - Reading from file tmpfile_stdout 19:22:19 INFO - Current package versions: 19:22:19 INFO - argparse == 1.2.1 19:22:19 INFO - blessings == 1.6 19:22:19 INFO - blobuploader == 1.2.4 19:22:19 INFO - docopt == 0.6.1 19:22:19 INFO - manifestparser == 1.1 19:22:19 INFO - mozInstall == 1.12 19:22:19 INFO - mozcrash == 0.17 19:22:19 INFO - mozdebug == 0.1 19:22:19 INFO - mozdevice == 0.48 19:22:19 INFO - mozfile == 1.2 19:22:19 INFO - mozhttpd == 0.7 19:22:19 INFO - mozinfo == 0.9 19:22:19 INFO - mozleak == 0.1 19:22:19 INFO - mozlog == 3.1 19:22:19 INFO - moznetwork == 0.27 19:22:19 INFO - mozprocess == 0.22 19:22:19 INFO - mozprofile == 0.28 19:22:19 INFO - mozrunner == 6.11 19:22:19 INFO - mozscreenshot == 0.1 19:22:19 INFO - mozsystemmonitor == 0.0 19:22:19 INFO - moztest == 0.7 19:22:19 INFO - mozversion == 1.4 19:22:19 INFO - psutil == 3.1.1 19:22:19 INFO - requests == 1.2.3 19:22:19 INFO - wsgiref == 0.1.2 19:22:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:22:19 INFO - Using env: {'DISPLAY': ':0', 19:22:19 INFO - 'HOME': '/home/cltbld', 19:22:19 INFO - 'LANG': 'en_US.UTF-8', 19:22:19 INFO - 'LANGUAGE': 'en_US:en', 19:22:19 INFO - 'LOGNAME': 'cltbld', 19:22:19 INFO - 'MAIL': '/var/mail/cltbld', 19:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:19 INFO - 'MOZ_NO_REMOTE': '1', 19:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:19 INFO - 'NO_EM_RESTART': '1', 19:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:19 INFO - 'PWD': '/builds/slave/test', 19:22:19 INFO - 'SHELL': '/bin/bash', 19:22:19 INFO - 'SHLVL': '1', 19:22:19 INFO - 'TERM': 'linux', 19:22:19 INFO - 'TMOUT': '86400', 19:22:19 INFO - 'USER': 'cltbld', 19:22:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:19 INFO - '_': '/tools/buildbot/bin/python'} 19:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:22:19 INFO - Cleaning up... 19:22:19 INFO - Return code: 0 19:22:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:22:19 INFO - Using env: {'DISPLAY': ':0', 19:22:19 INFO - 'HOME': '/home/cltbld', 19:22:19 INFO - 'LANG': 'en_US.UTF-8', 19:22:19 INFO - 'LANGUAGE': 'en_US:en', 19:22:19 INFO - 'LOGNAME': 'cltbld', 19:22:19 INFO - 'MAIL': '/var/mail/cltbld', 19:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:19 INFO - 'MOZ_NO_REMOTE': '1', 19:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:19 INFO - 'NO_EM_RESTART': '1', 19:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:19 INFO - 'PWD': '/builds/slave/test', 19:22:19 INFO - 'SHELL': '/bin/bash', 19:22:19 INFO - 'SHLVL': '1', 19:22:19 INFO - 'TERM': 'linux', 19:22:19 INFO - 'TMOUT': '86400', 19:22:19 INFO - 'USER': 'cltbld', 19:22:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:19 INFO - '_': '/tools/buildbot/bin/python'} 19:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:20 INFO - Downloading/unpacking jsonschema 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:20 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 19:22:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:22:21 INFO - Downloading/unpacking functools32 (from jsonschema) 19:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:22 INFO - Downloading functools32-3.2.3-2.tar.gz 19:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:22:22 INFO - warning: no files found matching '*.txt' 19:22:22 INFO - no previously-included directories found matching 'build' 19:22:22 INFO - no previously-included directories found matching 'dist' 19:22:22 INFO - no previously-included directories found matching '.git*' 19:22:22 INFO - Installing collected packages: jsonschema, functools32 19:22:22 INFO - Running setup.py install for functools32 19:22:22 INFO - warning: no files found matching '*.txt' 19:22:22 INFO - no previously-included directories found matching 'build' 19:22:22 INFO - no previously-included directories found matching 'dist' 19:22:22 INFO - no previously-included directories found matching '.git*' 19:22:22 INFO - Successfully installed jsonschema functools32 19:22:22 INFO - Cleaning up... 19:22:22 INFO - Return code: 0 19:22:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe850cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', '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 19:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:22:22 INFO - Using env: {'DISPLAY': ':0', 19:22:22 INFO - 'HOME': '/home/cltbld', 19:22:22 INFO - 'LANG': 'en_US.UTF-8', 19:22:22 INFO - 'LANGUAGE': 'en_US:en', 19:22:22 INFO - 'LOGNAME': 'cltbld', 19:22:22 INFO - 'MAIL': '/var/mail/cltbld', 19:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:22 INFO - 'MOZ_NO_REMOTE': '1', 19:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:22 INFO - 'NO_EM_RESTART': '1', 19:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:22 INFO - 'PWD': '/builds/slave/test', 19:22:22 INFO - 'SHELL': '/bin/bash', 19:22:22 INFO - 'SHLVL': '1', 19:22:22 INFO - 'TERM': 'linux', 19:22:22 INFO - 'TMOUT': '86400', 19:22:22 INFO - 'USER': 'cltbld', 19:22:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:22 INFO - '_': '/tools/buildbot/bin/python'} 19:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:22 INFO - Downloading/unpacking flake8 19:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:22:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:22:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:22:25 INFO - no previously-included directories found matching 'docs/_build' 19:22:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:22:25 INFO - Running setup.py install for pep8 19:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:22:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:22:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:22:25 INFO - no previously-included directories found matching 'docs/_build' 19:22:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:22:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:22:25 INFO - Cleaning up... 19:22:25 INFO - Return code: 0 19:22:25 INFO - Running post-action listener: _resource_record_post_action 19:22:25 INFO - Running post-action listener: _start_resource_monitoring 19:22:25 INFO - Starting resource monitoring. 19:22:25 INFO - ##### 19:22:25 INFO - ##### Running install step. 19:22:25 INFO - ##### 19:22:25 INFO - Running pre-action listener: _resource_record_pre_action 19:22:25 INFO - Running main action method: install 19:22:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:25 INFO - Reading from file tmpfile_stdout 19:22:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:22:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:22:25 INFO - Reading from file tmpfile_stdout 19:22:25 INFO - Output received: 19:22:25 INFO - Usage: mozinstall [options] installer 19:22:25 INFO - Options: 19:22:25 INFO - -h, --help show this help message and exit 19:22:25 INFO - -d DEST, --destination=DEST 19:22:25 INFO - Directory to install application into. [default: 19:22:25 INFO - "/builds/slave/test"] 19:22:25 INFO - --app=APP Application being installed. [default: firefox] 19:22:25 INFO - mkdir: /builds/slave/test/build/application 19:22:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:22:41 INFO - Reading from file tmpfile_stdout 19:22:41 INFO - Output received: 19:22:41 INFO - /builds/slave/test/build/application/firefox/firefox 19:22:41 INFO - Running post-action listener: _resource_record_post_action 19:22:41 INFO - ##### 19:22:41 INFO - ##### Running run-tests step. 19:22:41 INFO - ##### 19:22:41 INFO - Running pre-action listener: _resource_record_pre_action 19:22:41 INFO - Running main action method: run_tests 19:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:22:41 INFO - Python 2.7.3 19:22:41 INFO - Return code: 0 19:22:41 INFO - grabbing minidump binary from tooltool 19:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:41 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 0x1823410>, '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 0x1824310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18247a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:22:41 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 19:22:41 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 19:22:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:22:41 INFO - Return code: 0 19:22:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:22:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:22:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:22:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:22:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:22:42 INFO - Return code: 0 19:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:22:42 INFO - Using env: {'DISPLAY': ':0', 19:22:42 INFO - 'HOME': '/home/cltbld', 19:22:42 INFO - 'LANG': 'en_US.UTF-8', 19:22:42 INFO - 'LANGUAGE': 'en_US:en', 19:22:42 INFO - 'LOGNAME': 'cltbld', 19:22:42 INFO - 'MAIL': '/var/mail/cltbld', 19:22:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:22:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:42 INFO - 'MOZ_NO_REMOTE': '1', 19:22:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:42 INFO - 'NO_EM_RESTART': '1', 19:22:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:42 INFO - 'PWD': '/builds/slave/test', 19:22:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:22:42 INFO - 'SHELL': '/bin/bash', 19:22:42 INFO - 'SHLVL': '1', 19:22:42 INFO - 'TERM': 'linux', 19:22:42 INFO - 'TMOUT': '86400', 19:22:42 INFO - 'USER': 'cltbld', 19:22:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848', 19:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:42 INFO - '_': '/tools/buildbot/bin/python'} 19:22:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:22:42 INFO - mozversion application_buildid: 20160429164537 19:22:42 INFO - mozversion application_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 19:22:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:22:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:22:42 INFO - mozversion application_name: Firefox 19:22:42 INFO - mozversion application_remotingname: firefox-dev 19:22:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:22:42 INFO - mozversion application_vendor: Mozilla 19:22:42 INFO - mozversion application_version: 48.0a2 19:22:42 INFO - mozversion platform_buildid: 20160429164537 19:22:42 INFO - mozversion platform_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 19:22:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:22:42 INFO - mozversion platform_version: 48.0a2 19:22:42 INFO - using testdate: 1461982962 19:22:42 INFO - actual date: 1461982962 19:22:42 INFO - starting webserver on 'localhost:60326' 19:22:42 INFO - SUITE-START | Running 2 tests 19:22:42 INFO - TEST-START | dromaeo_css 19:22:42 INFO - operating with platform_type : linux_ 19:22:42 INFO - Initialising browser for dromaeo_css test... 19:22:42 INFO - TEST-INFO | started process 22154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJiOZYf/profile http://localhost:60326/getInfo.html) 19:22:46 INFO - PROCESS | 22154 | 19:22:46 INFO - PROCESS | 22154 | (process:22230): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:22:46 INFO - PROCESS | 22154 | __metrics Screen width/height:1600/1200 19:22:46 INFO - PROCESS | 22154 | colorDepth:24 19:22:46 INFO - PROCESS | 22154 | Browser inner width/height: 1024/697 19:22:46 INFO - PROCESS | 22154 | __metrics 19:22:47 ERROR - PROCESS | 22154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:22:48 INFO - TEST-INFO | 22154: exit 0 19:22:48 INFO - Browser initialized. 19:22:48 INFO - Running cycle 1/1 for dromaeo_css test... 19:22:48 INFO - TEST-INFO | started process 22281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJiOZYf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:50 INFO - PROCESS | 22281 | 19:22:50 INFO - PROCESS | 22281 | (process:22348): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:23:00 INFO - PROCESS | 22281 | RSS: Main: 152346624 19:23:00 INFO - PROCESS | 22281 | 19:23:49 INFO - PROCESS | 22281 | 1461983029725 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] 19:25:57 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60326/tests/dromaeo/cssquery-ext.html) 19:25:58 INFO - PROCESS | 22281 | RSS: Main: 155971584 19:25:58 INFO - PROCESS | 22281 | 19:29:00 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-ext.html (next: http://localhost:60326/tests/dromaeo/cssquery-jquery.html) 19:29:00 INFO - PROCESS | 22281 | RSS: Main: 153903104 19:29:00 INFO - PROCESS | 22281 | 19:32:02 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60326/tests/dromaeo/cssquery-mootools.html) 19:32:03 INFO - PROCESS | 22281 | RSS: Main: 153673728 19:32:03 INFO - PROCESS | 22281 | 19:35:04 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60326/tests/dromaeo/cssquery-prototype.html) 19:35:05 INFO - PROCESS | 22281 | RSS: Main: 153489408 19:35:05 INFO - PROCESS | 22281 | 19:38:07 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60326/tests/dromaeo/cssquery-yui.html) 19:38:08 INFO - PROCESS | 22281 | RSS: Main: 154767360 19:38:08 INFO - PROCESS | 22281 | 19:41:10 INFO - PROCESS | 22281 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-yui.html (next: http://localhost:60326/tests/dromaeo/cssquery-dojo.html) 19:41:11 INFO - PROCESS | 22281 | RSS: Main: 156168192 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | __start_tp_report 19:41:11 INFO - PROCESS | 22281 | _x_x_mozilla_page_load 19:41:11 INFO - PROCESS | 22281 | _x_x_mozilla_page_load_details 19:41:11 INFO - PROCESS | 22281 | |i|pagename|runs| 19:41:11 INFO - PROCESS | 22281 | |0;dojo.html;3291.177205698575;3366.1584603849037;3398.7281017518603;3422.435298175801;3429.2455659754846;5510.559155267579;5510.9448905510935;5522.088855338864;5552.250446189768;5562.110062390018;5458.208559758833;5517.5585953123755;5547.362053363864;5569.136783798507;5572.080606699899;5058.291839142523;5061.3420255366755;5095.439501654815;5098.566621837148;5120.385553733558;5021.196608542616;5136.58907287418;5159.613029022819;5228.08508511009;5238.607104467161;5018.64869459138;5033.748312584375;5042.672226305279;5082.923756143661;5178.637495375326;5058.468860769622;5063.544281014708;5089.109405853961;5110.105731496973;5111.744412779383;4884.023195360906;4993.350864387643;4998.6750861193905;5011.398632164163;5067.214581739836;5397.27136836526;5402.432744561804;5423.457654234585;5443.972780136074;5456.48163424474;5897.292324920994;5919.674417907014;5929.881402371929;5937.465628093449;5944;5816.331121920991;5956.52347812174;5976.4919981801595;5982.312034116088;5996.790112346047;5562.082256427685;5570.442955704397;5584.441555844423;5590;5602.047651899146;6013.278406591149;6027.939720602738;6030.427109424598;6040.124181993587;6055.152278680988;5729.885402292014;5798.565107616945;5799.18811366409;5886.411358864079;5911.4975227105315;5850.502707269845;5859.296884373903;5859.44335288147;5865;5867.266591676041;5779.624324418899;5820.185174075633;5825.1844741736195;5836.649801011953;5838.941610583925;5727;5889.057750759858;5892.823215303548;5921.348651648315;5977.282726072899;4475.977620111944;4496.3255511673515;4496.505384407713;4511.210538155809;4518.638508919278;4009.7594144351433;4044.919101617951;4065.16664083868;4065.57311482296;4070.2673518766314;5576.470235327637;5734;5781.566382521328;5788.479036886701;5796.101604251347;5960.731767070492;5961.195238642727;5979.5515336349945;5990.251218597676;6013.789517366871;5635.295588051494;5748.971255143698;5772.884542309131;5779.133130030529;5804.1293805929445;5097.643164978416;5102.668326558762;5136.049830781242;5155.6391052626705;5183.170692689152;6182;6233.625982441068;6238.532110091761;6242.344553821874;6256.31180570146;5924.200232968494;5997.190379298739;6003.7898673546215;6007.699615019232;6023.096535519707;6142.600730952474;6157.907631385443;6159.384061593805;6165.660888651168;6170.876582468236;5818.738156782871;5822.446867547576;5825.2135961644635;5841.649501029951;5882.382349853375;5916.674582897982;5936.643801371932;5951.166836642787;6000.189974353407;6020.1270815730595;5752.9712351437975;5789.913151302818;5798;5802.361740208489;5807.477327040418;5735.254416925773;5763.164341170591;5780.768769249351;5804.65172089676;5804.82585522435;5553.72231388437;5722.141678748221;5807.186993820953;5827.038538641246;5842.503387212135;5728.484436400744;5775.971120144372;5784.21913041734;5790.305163380422;5803.7968671096305;5580.888382232251;5659.971700141473;5670.461306175906;5670.546356291405;5681.119426488901 19:41:11 INFO - PROCESS | 22281 | |1;ext.html;616.432881748791;665.747016133869;669.0900375489335;669.34069941108;669.5882032549983;39367;40222.79888600556;40254.1949161017;40413.59586404135;40637;42293.788531057304;43273.56726432735;43296;43392.3491147633;43563;8786.384953053288;8998.730038098867;9019.684311049115;9021.052789457111;9031.683891063814;8773.824523509526;8890.599923003449;8918.241949434307;9174.770630734218;9224.769380765467;9193.494357810318;9252.953735231315;9270.536473176347;9277.97942226358;9284.257259419264;9144.314176436794;9180.495072770995;9198.126178013112;9246.029166937442;9246.537673116318;9086.45481271126;9119.908800912039;9129.954350228207;9133.771655708593;9185.954070229673;44813.327800083025;44926.10147797059;45056.09887802258;45074.32388514175;45139.32291015638;3939.409088636699;3968.3650615901315;3985.143194213258;4019.457373254632;4076.8369265229353;33359.83320083408;33517.6648233517;33917;34133.14667133317;34275.14312142191;4478.686491945565;4594.287885377772;4603.792829322689;4633.096546173498;4649.209634362132;348697;350107;350406;352243;354910;36599.81700091482;62404.375956239855;63743.76896808682;63747.36252637414;63772.36227637757;36463.088422789646;36615.26769464596;36698.8165059173;36731.81634091866;36780.44829327562;16965.745513817303;16986.150692465326;17226.741598876026;17251.137443127795;17278.13609319529;14679.55961321162;14692.706145877022;14760.114393136446;14787.556373308818;14792.11247325164;9428.434293942386;9508.762280943032;9519.476428796483;9523.476208808443;9539;3528.1179705073732;3615.1865830188;3629.292288003814;3664.4686520454384;3677.705783537364;1128.2046157458972;1132.7143691909741;1136.4374634555948;1165.0737663557493;1175.3770501634147;33437.665623343455;33440.832795835864;33706.66293337084;33996.150096247795;34193.487097693556;1202.939853007346;1272.4210484229654;1279.7440511897657;1333.1334632488765;1337.3781191745884;17483.65032699339;18049.877147433217;18073.08372553127;18074.548136296435;18171.454856354332;287837;317310;320754;323385;560629;57050;57844.71077644585;58089.128663070085;58204;58380.41619583835;1505.9849401506065;1543.3055125193484;1544.7219500489796;1554.6890621875896;1665.9920747947317;31782.364352713277;31811.20471988219;32052.51921221137;32696.673033269362;32826.50760238646;57057.714711426175;57124.71437642785;57280.71359643175;57630;57654.13518797305;429021;429830;430091;430264;431852;31123.84438077795;31698.366032679678;31706;31777.046688599377;41887.16225675408;44876.55123448724;45659;45965.540344597466;46062.07875842397;46533.06933861371;38857.80571097126;38873.61126388813;39594.80202598969;39984.40023399593;41122;42891;43044.923876903325;43222.351664725684;43718.78140609276;43736;42230.15539689128;42860.57139428566;43115.56884431116;43513.78243108764;44708.32937505875;37221.813890930374;37367.62632373641;37552.2489550202;38320.6167938317;38435;28655.426891461637;29302;29613.407731845673;29676;29821.254468638457 19:41:11 INFO - PROCESS | 22281 | |2;jquery.html;414.88590637574663;423.4600883873063;423.9130978149479;425.1709167124107;427.89944363074693;18603.62792744146;18758;19248.615027699456;19569.31507397238;19943.60112797747;19099.904500477478;19611.705824412646;19760.802391976074;19836.504087397785;19888.502787430323;5135.204043373274;5433.510984011438;5466.972665136669;5490.094134467828;5493.038718224315;4157.085441202946;5420.214068959998;5491.203775452557;5838.591298609099;6152.261728592553;6088.4215999479975;6108.572399932006;6126.142340072372;6138.14066030756;6141.263048434194;5844.912326315088;6100.450959413674;6104.542159338067;6108.511319094484;6112.113743507211;5768.653880767126;5864.1203819427;5924.229850119457;5924.7926322578505;5926.614770039933;14922.70154596902;15180.696386072326;15204.771928421083;15261.847381526153;21561;2374.1927744566756;2375.762423757628;2467.987660061688;2472.7527247275307;2483.130904183521;10430.478476076165;10473.214508911862;10861.565537378574;10908.563657453693;11225.326480411202;2066.0909199951975;2082.354470114254;2123.2674727219087;2148.5702859428175;2150.064721846002;80613;81926.59036704779;83106;84948.57525712332;86664.5666771662;11166.385848778395;11554.364509951865;11677.240979336317;11926.473148770026;12361.196522226026;16670.249838757285;16679.416220432227;16806.243719032675;16843.494695159166;16889.91555042217;9071.319651026199;9146.54267286633;9156.404833685789;9360.11078947499;9372.390794598467;8765.868511972325;8837.690680826141;8928.419652722552;9091.49654284527;9222.815543689088;5042.924356134661;5062;5067.189249720027;5158.638895277295;5188.247704082887;1890.0738638067523;2086.9582608347746;2107.346722516025;2147.914083436645;2163.307741522729;1012.3116280928891;1098.9285696429706;1100.1968562948932;1219.1344145656506;1238.1147479552164;19084.332048378517;19542.12060457283;19742.506437338896;19950.800491994894;20024.49938751543;1081.1729027294127;1124.6850881753123;1161.9941900290614;1162.5349860055876;1209.3227792436264;10777.83833242502;11184;11227.101831853432;11243.325400475998;11269.943650281695;388734;389961;390340;396119;528855;95500.52249738846;97082.51458742803;101997;102188;109575;1132.8640563132476;1150.1316506037888;1173.266708307308;1180.3036208636945;1180.5963755193177;17781.377651782124;18183.45449636513;18240.72638910444;18299.634007319513;18352.357667481574;40615;41024;41661;42473;42869.356959646255;57275.42724572701;58015;59349;59353;59592.404075958686;8682;8789.516576588348;8798.736037918872;9077.45535267886;9130.132637399436;10233.897661023295;13739.175649461064;13842.584722458343;13920.58238252854;14180.574582762534;11649.475773590038;12487.250764954131;12493;12505.437255323714;12579.308138052129;11693;11943.641690749291;12236.816447753114;12308.199967002116;12369.752604948031;12511.12422130442;12553.748925021266;12576.622701318975;12694.809577856155;12808.615741527396;8631.654733810828;8711.477311361085;8815.735527934172;8865.64537418496;8942.37403381757;11681.182317237712;12027.819582706092;12230.327331996825;12286.75426491483;12615.116941813985 19:41:11 INFO - PROCESS | 22281 | |3;mootools.html;1617.1348328644178;1650.9174541272937;1836.559225785811;1892.6120145370191;1893.5266183454137;7434.553926764384;8009.759707208786;8041.396895232851;8190.05814331352;8235.752927412179;8054.315383192436;8087.433879628428;8132.227438393358;8140.755777326674;8171.142030086845;2344.742078371382;2369.656399822025;2378.9286321410386;2381.30942026812;2383.392234980078;2340.32130682102;2358.587247231736;2373.9881300593474;2402.231285988484;2405.2183040511904;2308.53829234153;2343.425860664131;2344.284993077111;2385.0340612052146;2389.7490763469846;2241.68616393705;2247.325802259316;2261.683364328995;2262.1403866530613;2265.660150977358;2227.3095340444515;2253.7746225377496;2260;2261.739899911515;2268.727752669674;8193.180681931819;8240.093589705128;8298.751037468825;8318.12659670732;8338.291245244161;4994.550490455877;5164.25118357836;5184.429712731597;5191.299174611417;5195.584353251731;3150.8582113804932;3184.283536204359;3304.8182349970743;3360.41192791263;3367.2087059540986;1016.293675895253;1019.1642852860657;1020.4234607446768;1034.3793723765755;1048.895110488945;11189.832152517718;11218.719532011683;11348.943255283753;11456.599019034376;11465.942670286595;4568.931466028012;4583.106294272585;4654.604358629486;4671.5328467153695;4707.458642256116;9507.429554226768;9584.472853992958;9636.566354514063;9654.372465789702;9834.704958851245;5171.3018742469285;5241.0828105081455;5251.186066159751;5253.238280449314;5277.551408130275;4223.5565265646665;4674.579287864109;4721.6694831362165;4841.927371089437;4847.709137451764;3887.8833634990997;3918.1575961168487;3962.663173630274;4014.3376342903093;4189.0574620710095;1283.4994352202648;1284.9550265740654;1291.341415877909;1294.7345794112184;1312.330711337206;936.2042264075482;999.2954966748425;1010.8483727440796;1065.738893970982;1081.1404933078222;5969.970150149222;6036.728347224385;6071.574989750763;6114;6255.812325630239;1005.4470041477158;1068.4978060311641;1069.2034434346463;1075.4353964168874;1080.8756992945755;4072.6945479089186;4284.207421626947;4290.892727681833;4305.74165550068;4369.104333611602;9932.702018939442;10072.546735396925;10143.949280253699;10151.492425378849;10156.085952264331;9551.808963820684;9904.900950990543;10213.948930255301;10238.385696858213;10290.382577045251;7750.5737184454265;7854.764357069297;7862.095858976177;7874.370050395954;7934.404919630935;5732.656040637575;5815.331236907809;5941.494972927177;5969.283685957713;6003.6397816131175;9431.198348140484;9579.233661307218;9616.749822523027;9671.17794987434;9704;9428.622855085994;9525.761855953378;9527.714168574954;9800.607975681178;9819.85270220933;6939.132608423947;7362.190159082604;7389.519681220703;7642.617869106633;7646.082470103624;7994.320482759031;7999.840003199787;8006.159353268056;8104.2300981409035;8130.837383252184;7321.560706357635;7405.703771849281;7444.478886478111;7449.962750186214;7487.47587668858;7236.167840698387;7245.746398876014;7287.489875708649;7339.486235963432;7421.406287497095;6643.435307998681;6647.800565983028;6664.733410663519;6692.330766923269;6718.428933540704;5243.213517972335;5294.497022782984;5334.51989320963;5392.892142157213;5483.122700367922;5466.125419932791;5527.364353099445;5535.529479994246;5554.611177217556;5583.609147359646 19:41:11 INFO - PROCESS | 22281 | |4;prototype.html;333.6463348850219;340.98124603146834;344.49015457123454;350.61782656903983;353.63222248861183;5609.70002299057;5753.194552762617;5756.913646295304;5790.478856902878;5822.184894114827;5639.971800141004;5640.971795141018;5644.887102257952;5654.180143879145;5670.4896559309655;4198.412222288875;4261.318189089746;4395.120975804836;4426.048399594087;4447.84432544861;4362.781860906958;4436.64506839452;4452.265376212921;4456.6880318377725;4467.7542735149555;4366.912661746779;4412.338149277618;4433.623142032931;4434.667399945001;4443.466783985927;4322.783860806962;4392.560743925614;4402.295632698753;4427.1367083418745;4434.157510073108;3877.9806100969595;3879.8254078566533;3920.157166209279;3925.509311336083;3936.8031598420253;5419.078756611386;5450.781968721247;5461.5357694596005;5465.147071314714;5516.862078448031;4952.87617809554;5087.313212716273;5091.872703182413;5105.438401775802;5129.3075434816565;5780.797672081457;5862.9153606582495;5905.43898329658;5929.703514824285;5939.524838012949;4299.871003869889;4335.219660461115;4338.175746608166;4343.913121737579;4352.869413917588;6053.061775424816;6058.606190597597;6126.540509461764;6210.937890621126;6219.657918814463;4414.933775993362;4415.161119387306;4426.919347906479;4446.221911165533;4447.911041779146;4473.1277400907165;4481.887952801141;4483.820647174141;4488.955110448919;4492.3710680504755;4894.486078961729;5051.949480505148;5071;5077.1876499759865;5086.135356989321;5932.495737862244;5964.850878728066;5973.283206015306;6019.247594050744;6023.969880150571;1499.482678475924;1612;1641.7209074457132;1659.31138577489;1664.4257731082757;1000.1898462245459;1032.6437379104198;1050.1598721023151;1051.279873286801;1062.7874425115008;6218.9378106219265;6221.4089661482085;6227.283862355796;6266.185395898504;6280.748770049238;6555.475561955032;6563.1796025496815;6564.326096845274;6611.140551728341;6615.140031795836;5716.685582293014;5957.851053723692;6030.5778595497895;6031.2159419276095;6046.516278697693;3582.659647333499;3584.068142282973;3596.694280986093;3604.6034936157002;3610.4764809102535;6212.72042758077;6492.480601551959;6508.056331831858;6544.836379090466;7014.368706816309;6366.872662546816;6369.172007638977;6383.585066970632;6406.839829004219;6427.164468619049;6299.338569450233;6500.562289141572;6506.707198176094;6514.185726784152;6561.967190164019;6170.907436388368;6228.660837919869;6266.404691554295;6284.183056202664;6311;5938.732757025858;6194.26560563043;6205.81382558524;6217.197012866218;6228.377162283736;6517;6538.705758240986;6542.509311801729;6549.901751473827;6550.541462097798;4227.1123064155645;4248.596383343577;4270.893227669333;4296.548862369406;4300.3549467580115;6181.84545386369;6233.937660623335;6256.874862502816;6308.432241098323;6323.873522529616;6121.112438696275;6132.46688327918;6140.938590614215;6145.72344244519;6165.722542485689;5893.145493903446;5992.310884248192;5995.520358371233;6085.4523092921845;6101.328853826164;5831.504322132666;5945.721669841005;5976.133460648269;5994.790182343597;6015.789447369321;6039.6678182698615;6062.666553339609;6073.878522429615;6125.9693701531205;6160.106784516131;5682.5453963681975;5914.615549989237;5928.525717942641;5959.851003724768;5979.252593425822 19:41:11 INFO - PROCESS | 22281 | |5;yui.html;782.3662833105184;817.0685418622769;818.3289702443998;827.288531862598;850.4387104511025;14980.775288370683;15051.322690478928;15187.696246075071;15233.542993710178;15358.923205383986;14334.42662293507;14383.208923509203;14421.855781442182;14433;14439;883.5670521444478;901.3420203251646;928.7631653928239;935.9017303183169;939.6899023322321;924.653255029364;934.1685899549373;935.4247138010143;936.0312077000306;941.223490620241;960.4381436859411;962.4946902876011;962.8603852441391;966.830804609194;973.1047436358532;955.4267439536292;956.4643799472283;957.5020989085637;959.7504648791295;966.7099870038995;706.8374273917028;707.9292070792931;711.7117567385217;712.4087007783527;712.7006657203935;16417.83582164175;16422;16430.507084787474;16462.42381516641;16491.257893394704;13354.198748075049;13989.860101398957;14416.279186040656;14444.422223111063;14468;12380.133390662657;12408.193467424679;12458.439370228361;12517.248965062125;12705.428255728515;3930.7051971102283;4004.6395824375654;4005.2790497710403;4008.6793056555407;4032.6169013943627;56618.71690641562;57596.71201644007;58186.99999999958;58202.70898645522;58528.41471585272;11676.357800320893;11696.88303116958;11730.237534560227;12071.3360765157;12085.577004804789;20212.29256975999;20559.177632894814;20622.484437889172;20646.690299645517;20703.689444658343;8382.916170838214;8443;8487.830243395098;8522.57387130641;8543.487390756574;4803.711777293303;5008;5048.167052436307;5078.644494885397;5193.091209038404;3566.518519999767;3596.1009747563107;3600.0279924420784;3600.4059330210744;3610.891673249807;609.8993666045142;611.9418655227746;615.0681717198358;621.1459243540132;626.2766504687094;741.3587247031279;751.3538357012965;781.261707686231;829.9792505187298;843.0768308701962;10000.949995249977;10732.463376831127;10755.83866242007;10824.567017319376;10864.945675271572;794.7973266816924;798.9201079892081;833.3874602167402;836.0677844203669;836.5858899844494;4505.324201369821;4615.607673347803;4619.260918253063;4626.421697287839;4718.669693121448;62249.37750622526;64470.67764661147;67660;68426;70184.29815701778;54659;55642.72178639081;57565.424345756845;58443.70778146082;59045.40954590399;54796;55241.862974285425;55309.99999999919;55429.44570554243;55879.44120558743;9857.901420985698;9898;9949.950250248703;10020.56774937161;10163.695089147337;35147.121321967155;35586.04276764699;35599.28801424009;35854.64145358513;35923.46114808332;49461.258081129534;49770.25344619761;49809.50190498048;50091.74954125352;50159.74920125376;12153.69615759613;12306.261624302571;12363.93818030904;12427.937860311002;12516.374181291081;12494;13041.543545975845;13964.441422342992;14187.574372768833;15378.615534611725;13011.414486347947;13593.59219223425;13726.725465490834;14501.637459063608;14816.036957597722;13090.738185236052;13355;13538;13965.860341396456;14278;14174;14219.289035547974;14370.425182992563;14420.783688244475;14793.408263669333;11699.2980421175;11818.113641476752;11878.703032424259;12116.843476272285;12319.795515462949;12190.2076365036;12357.93821030889;12384.62846114618;12443.875561244271;12495 19:41:11 INFO - PROCESS | 22281 | __end_tp_report 19:41:11 INFO - PROCESS | 22281 | __start_cc_report 19:41:11 INFO - PROCESS | 22281 | _x_x_mozilla_cycle_collect,327 19:41:11 INFO - PROCESS | 22281 | __end_cc_report 19:41:11 INFO - PROCESS | 22281 | __startTimestamp1461984071010__endTimestamp 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | ------- Summary: start ------- 19:41:11 INFO - PROCESS | 22281 | Number of tests: 6 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#0] dojo.html Cycles:165 Average:5521.78 Median:5772.88 stddev:606.10 (10.5%) stddev-sans-first:582.15 19:41:11 INFO - PROCESS | 22281 | Values: 3291.2 3366.2 3398.7 3422.4 3429.2 5510.6 5510.9 5522.1 5552.3 5562.1 5458.2 5517.6 5547.4 5569.1 5572.1 5058.3 5061.3 5095.4 5098.6 5120.4 5021.2 5136.6 5159.6 5228.1 5238.6 5018.6 5033.7 5042.7 5082.9 5178.6 5058.5 5063.5 5089.1 5110.1 5111.7 4884.0 4993.4 4998.7 5011.4 5067.2 5397.3 5402.4 5423.5 5444.0 5456.5 5897.3 5919.7 5929.9 5937.5 5944.0 5816.3 5956.5 5976.5 5982.3 5996.8 5562.1 5570.4 5584.4 5590.0 5602.0 6013.3 6027.9 6030.4 6040.1 6055.2 5729.9 5798.6 5799.2 5886.4 5911.5 5850.5 5859.3 5859.4 5865.0 5867.3 5779.6 5820.2 5825.2 5836.6 5838.9 5727.0 5889.1 5892.8 5921.3 5977.3 4476.0 4496.3 4496.5 4511.2 4518.6 4009.8 4044.9 4065.2 4065.6 4070.3 5576.5 5734.0 5781.6 5788.5 5796.1 5960.7 5961.2 5979.6 5990.3 6013.8 5635.3 5749.0 5772.9 5779.1 5804.1 5097.6 5102.7 5136.0 5155.6 5183.2 6182.0 6233.6 6238.5 6242.3 6256.3 5924.2 5997.2 6003.8 6007.7 6023.1 6142.6 6157.9 6159.4 6165.7 6170.9 5818.7 5822.4 5825.2 5841.6 5882.4 5916.7 5936.6 5951.2 6000.2 6020.1 5753.0 5789.9 5798.0 5802.4 5807.5 5735.3 5763.2 5780.8 5804.7 5804.8 5553.7 5722.1 5807.2 5827.0 5842.5 5728.5 5776.0 5784.2 5790.3 5803.8 5580.9 5660.0 5670.5 5670.5 5681.1 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#1] ext.html Cycles:180 Average:54898.44 Median:40525.30 stddev:102156.31 (252.1%) stddev-sans-first:102361.59 19:41:11 INFO - PROCESS | 22281 | Values: 616.4 665.7 669.1 669.3 669.6 39367.0 40222.8 40254.2 40413.6 40637.0 42293.8 43273.6 43296.0 43392.3 43563.0 8786.4 8998.7 9019.7 9021.1 9031.7 8773.8 8890.6 8918.2 9174.8 9224.8 9193.5 9253.0 9270.5 9278.0 9284.3 9144.3 9180.5 9198.1 9246.0 9246.5 9086.5 9119.9 9130.0 9133.8 9186.0 44813.3 44926.1 45056.1 45074.3 45139.3 3939.4 3968.4 3985.1 4019.5 4076.8 33359.8 33517.7 33917.0 34133.1 34275.1 4478.7 4594.3 4603.8 4633.1 4649.2 348697.0 350107.0 350406.0 352243.0 354910.0 36599.8 62404.4 63743.8 63747.4 63772.4 36463.1 36615.3 36698.8 36731.8 36780.4 16965.7 16986.2 17226.7 17251.1 17278.1 14679.6 14692.7 14760.1 14787.6 14792.1 9428.4 9508.8 9519.5 9523.5 9539.0 3528.1 3615.2 3629.3 3664.5 3677.7 1128.2 1132.7 1136.4 1165.1 1175.4 33437.7 33440.8 33706.7 33996.2 34193.5 1202.9 1272.4 1279.7 1333.1 1337.4 17483.7 18049.9 18073.1 18074.5 18171.5 287837.0 317310.0 320754.0 323385.0 560629.0 57050.0 57844.7 58089.1 58204.0 58380.4 1506.0 1543.3 1544.7 1554.7 1666.0 31782.4 31811.2 32052.5 32696.7 32826.5 57057.7 57124.7 57280.7 57630.0 57654.1 429021.0 429830.0 430091.0 430264.0 431852.0 31123.8 31698.4 31706.0 31777.0 41887.2 44876.6 45659.0 45965.5 46062.1 46533.1 38857.8 38873.6 39594.8 39984.4 41122.0 42891.0 43044.9 43222.4 43718.8 43736.0 42230.2 42860.6 43115.6 43513.8 44708.3 37221.8 37367.6 37552.2 38320.6 38435.0 28655.4 29302.0 29613.4 29676.0 29821.3 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#2] jquery.html Cycles:180 Average:27508.85 Median:2097.15 stddev:70384.49 (3356.2%) stddev-sans-first:70552.54 19:41:11 INFO - PROCESS | 22281 | Values: 414.9 423.5 423.9 425.2 427.9 18603.6 18758.0 19248.6 19569.3 19943.6 19099.9 19611.7 19760.8 19836.5 19888.5 5135.2 5433.5 5467.0 5490.1 5493.0 4157.1 5420.2 5491.2 5838.6 6152.3 6088.4 6108.6 6126.1 6138.1 6141.3 5844.9 6100.5 6104.5 6108.5 6112.1 5768.7 5864.1 5924.2 5924.8 5926.6 14922.7 15180.7 15204.8 15261.8 21561.0 2374.2 2375.8 2468.0 2472.8 2483.1 10430.5 10473.2 10861.6 10908.6 11225.3 2066.1 2082.4 2123.3 2148.6 2150.1 80613.0 81926.6 83106.0 84948.6 86664.6 11166.4 11554.4 11677.2 11926.5 12361.2 16670.2 16679.4 16806.2 16843.5 16889.9 9071.3 9146.5 9156.4 9360.1 9372.4 8765.9 8837.7 8928.4 9091.5 9222.8 5042.9 5062.0 5067.2 5158.6 5188.2 1890.1 2087.0 2107.3 2147.9 2163.3 1012.3 1098.9 1100.2 1219.1 1238.1 19084.3 19542.1 19742.5 19950.8 20024.5 1081.2 1124.7 1162.0 1162.5 1209.3 10777.8 11184.0 11227.1 11243.3 11269.9 388734.0 389961.0 390340.0 396119.0 528855.0 95500.5 97082.5 101997.0 102188.0 109575.0 1132.9 1150.1 1173.3 1180.3 1180.6 17781.4 18183.5 18240.7 18299.6 18352.4 40615.0 41024.0 41661.0 42473.0 42869.4 57275.4 58015.0 59349.0 59353.0 59592.4 8682.0 8789.5 8798.7 9077.5 9130.1 10233.9 13739.2 13842.6 13920.6 14180.6 11649.5 12487.3 12493.0 12505.4 12579.3 11693.0 11943.6 12236.8 12308.2 12369.8 12511.1 12553.7 12576.6 12694.8 12808.6 8631.7 8711.5 8815.7 8865.6 8942.4 11681.2 12027.8 12230.3 12286.8 12615.1 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#3] mootools.html Cycles:180 Average:5591.10 Median:5218.33 stddev:3009.84 (57.7%) stddev-sans-first:3003.47 19:41:11 INFO - PROCESS | 22281 | Values: 1617.1 1650.9 1836.6 1892.6 1893.5 7434.6 8009.8 8041.4 8190.1 8235.8 8054.3 8087.4 8132.2 8140.8 8171.1 2344.7 2369.7 2378.9 2381.3 2383.4 2340.3 2358.6 2374.0 2402.2 2405.2 2308.5 2343.4 2344.3 2385.0 2389.7 2241.7 2247.3 2261.7 2262.1 2265.7 2227.3 2253.8 2260.0 2261.7 2268.7 8193.2 8240.1 8298.8 8318.1 8338.3 4994.6 5164.3 5184.4 5191.3 5195.6 3150.9 3184.3 3304.8 3360.4 3367.2 1016.3 1019.2 1020.4 1034.4 1048.9 11189.8 11218.7 11348.9 11456.6 11465.9 4568.9 4583.1 4654.6 4671.5 4707.5 9507.4 9584.5 9636.6 9654.4 9834.7 5171.3 5241.1 5251.2 5253.2 5277.6 4223.6 4674.6 4721.7 4841.9 4847.7 3887.9 3918.2 3962.7 4014.3 4189.1 1283.5 1285.0 1291.3 1294.7 1312.3 936.2 999.3 1010.8 1065.7 1081.1 5970.0 6036.7 6071.6 6114.0 6255.8 1005.4 1068.5 1069.2 1075.4 1080.9 4072.7 4284.2 4290.9 4305.7 4369.1 9932.7 10072.5 10143.9 10151.5 10156.1 9551.8 9904.9 10213.9 10238.4 10290.4 7750.6 7854.8 7862.1 7874.4 7934.4 5732.7 5815.3 5941.5 5969.3 6003.6 9431.2 9579.2 9616.7 9671.2 9704.0 9428.6 9525.8 9527.7 9800.6 9819.9 6939.1 7362.2 7389.5 7642.6 7646.1 7994.3 7999.8 8006.2 8104.2 8130.8 7321.6 7405.7 7444.5 7450.0 7487.5 7236.2 7245.7 7287.5 7339.5 7421.4 6643.4 6647.8 6664.7 6692.3 6718.4 5243.2 5294.5 5334.5 5392.9 5483.1 5466.1 5527.4 5535.5 5554.6 5583.6 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#4] prototype.html Cycles:180 Average:5113.61 Median:5785.64 stddev:1518.35 (26.2%) stddev-sans-first:1479.61 19:41:11 INFO - PROCESS | 22281 | Values: 333.6 341.0 344.5 350.6 353.6 5609.7 5753.2 5756.9 5790.5 5822.2 5640.0 5641.0 5644.9 5654.2 5670.5 4198.4 4261.3 4395.1 4426.0 4447.8 4362.8 4436.6 4452.3 4456.7 4467.8 4366.9 4412.3 4433.6 4434.7 4443.5 4322.8 4392.6 4402.3 4427.1 4434.2 3878.0 3879.8 3920.2 3925.5 3936.8 5419.1 5450.8 5461.5 5465.1 5516.9 4952.9 5087.3 5091.9 5105.4 5129.3 5780.8 5862.9 5905.4 5929.7 5939.5 4299.9 4335.2 4338.2 4343.9 4352.9 6053.1 6058.6 6126.5 6210.9 6219.7 4414.9 4415.2 4426.9 4446.2 4447.9 4473.1 4481.9 4483.8 4489.0 4492.4 4894.5 5051.9 5071.0 5077.2 5086.1 5932.5 5964.9 5973.3 6019.2 6024.0 1499.5 1612.0 1641.7 1659.3 1664.4 1000.2 1032.6 1050.2 1051.3 1062.8 6218.9 6221.4 6227.3 6266.2 6280.7 6555.5 6563.2 6564.3 6611.1 6615.1 5716.7 5957.9 6030.6 6031.2 6046.5 3582.7 3584.1 3596.7 3604.6 3610.5 6212.7 6492.5 6508.1 6544.8 7014.4 6366.9 6369.2 6383.6 6406.8 6427.2 6299.3 6500.6 6506.7 6514.2 6562.0 6170.9 6228.7 6266.4 6284.2 6311.0 5938.7 6194.3 6205.8 6217.2 6228.4 6517.0 6538.7 6542.5 6549.9 6550.5 4227.1 4248.6 4270.9 4296.5 4300.4 6181.8 6233.9 6256.9 6308.4 6323.9 6121.1 6132.5 6140.9 6145.7 6165.7 5893.1 5992.3 5995.5 6085.5 6101.3 5831.5 5945.7 5976.1 5994.8 6015.8 6039.7 6062.7 6073.9 6126.0 6160.1 5682.5 5914.6 5928.5 5959.9 5979.3 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - PROCESS | 22281 | [#5] yui.html Cycles:180 Average:15935.61 Median:4020.65 stddev:18265.98 (454.3%) stddev-sans-first:18281.78 19:41:11 INFO - PROCESS | 22281 | Values: 782.4 817.1 818.3 827.3 850.4 14980.8 15051.3 15187.7 15233.5 15358.9 14334.4 14383.2 14421.9 14433.0 14439.0 883.6 901.3 928.8 935.9 939.7 924.7 934.2 935.4 936.0 941.2 960.4 962.5 962.9 966.8 973.1 955.4 956.5 957.5 959.8 966.7 706.8 707.9 711.7 712.4 712.7 16417.8 16422.0 16430.5 16462.4 16491.3 13354.2 13989.9 14416.3 14444.4 14468.0 12380.1 12408.2 12458.4 12517.2 12705.4 3930.7 4004.6 4005.3 4008.7 4032.6 56618.7 57596.7 58187.0 58202.7 58528.4 11676.4 11696.9 11730.2 12071.3 12085.6 20212.3 20559.2 20622.5 20646.7 20703.7 8382.9 8443.0 8487.8 8522.6 8543.5 4803.7 5008.0 5048.2 5078.6 5193.1 3566.5 3596.1 3600.0 3600.4 3610.9 609.9 611.9 615.1 621.1 626.3 741.4 751.4 781.3 830.0 843.1 10000.9 10732.5 10755.8 10824.6 10864.9 794.8 798.9 833.4 836.1 836.6 4505.3 4615.6 4619.3 4626.4 4718.7 62249.4 64470.7 67660.0 68426.0 70184.3 54659.0 55642.7 57565.4 58443.7 59045.4 54796.0 55241.9 55310.0 55429.4 55879.4 9857.9 9898.0 9950.0 10020.6 10163.7 35147.1 35586.0 35599.3 35854.6 35923.5 49461.3 49770.3 49809.5 50091.7 50159.7 12153.7 12306.3 12363.9 12427.9 12516.4 12494.0 13041.5 13964.4 14187.6 15378.6 13011.4 13593.6 13726.7 14501.6 14816.0 13090.7 13355.0 13538.0 13965.9 14278.0 14174.0 14219.3 14370.4 14420.8 14793.4 11699.3 11818.1 11878.7 12116.8 12319.8 12190.2 12357.9 12384.6 12443.9 12495.0 19:41:11 INFO - PROCESS | 22281 | -------- Summary: end -------- 19:41:11 INFO - PROCESS | 22281 | 19:41:11 INFO - TEST-INFO | 22281: exit 0 19:41:11 INFO - TEST-OK | dromaeo_css | took 1109155ms 19:41:11 INFO - TEST-START | kraken 19:41:11 INFO - operating with platform_type : linux_ 19:41:11 INFO - Initialising browser for kraken test... 19:41:11 INFO - TEST-INFO | started process 22523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4JWlK9/profile http://localhost:60326/getInfo.html) 19:41:15 INFO - PROCESS | 22523 | 19:41:15 INFO - PROCESS | 22523 | (process:22603): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:41:16 INFO - PROCESS | 22523 | __metrics Screen width/height:1600/1200 19:41:16 INFO - PROCESS | 22523 | colorDepth:24 19:41:16 INFO - PROCESS | 22523 | Browser inner width/height: 1024/697 19:41:16 INFO - PROCESS | 22523 | __metrics 19:41:16 ERROR - PROCESS | 22523 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:41:17 INFO - TEST-INFO | 22523: exit 0 19:41:17 INFO - Browser initialized. 19:41:17 INFO - Running cycle 1/1 for kraken test... 19:41:17 INFO - TEST-INFO | started process 22654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4JWlK9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:19 INFO - PROCESS | 22654 | 19:41:19 INFO - PROCESS | 22654 | (process:22723): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:41:29 INFO - PROCESS | 22654 | RSS: Main: 152498176 19:41:29 INFO - PROCESS | 22654 | 19:41:31 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-beat-detection) 19:41:32 INFO - PROCESS | 22654 | RSS: Main: 157290496 19:41:32 INFO - PROCESS | 22654 | 19:41:35 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-dft) 19:41:36 INFO - PROCESS | 22654 | RSS: Main: 157995008 19:41:36 INFO - PROCESS | 22654 | 19:41:38 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-fft) 19:41:39 INFO - PROCESS | 22654 | RSS: Main: 158281728 19:41:39 INFO - PROCESS | 22654 | 19:41:41 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-oscillator) 19:41:42 INFO - PROCESS | 22654 | RSS: Main: 158191616 19:41:42 INFO - PROCESS | 22654 | 19:41:44 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:41:45 INFO - PROCESS | 22654 | RSS: Main: 157859840 19:41:45 INFO - PROCESS | 22654 | 19:41:48 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-darkroom) 19:41:48 INFO - PROCESS | 22654 | RSS: Main: 157827072 19:41:48 INFO - PROCESS | 22654 | 19:41:52 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-desaturate) 19:41:52 INFO - PROCESS | 22654 | RSS: Main: 158056448 19:41:52 INFO - PROCESS | 22654 | 19:41:55 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60326/tests/kraken/driver.html?testName=json-parse-financial) 19:41:56 INFO - PROCESS | 22654 | RSS: Main: 158068736 19:41:56 INFO - PROCESS | 22654 | 19:41:57 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60326/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:41:58 INFO - PROCESS | 22654 | RSS: Main: 157892608 19:41:58 INFO - PROCESS | 22654 | 19:41:59 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:42:00 INFO - PROCESS | 22654 | RSS: Main: 158130176 19:42:00 INFO - PROCESS | 22654 | 19:42:02 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:42:03 INFO - PROCESS | 22654 | RSS: Main: 157872128 19:42:03 INFO - PROCESS | 22654 | 19:42:05 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:42:06 INFO - PROCESS | 22654 | RSS: Main: 158474240 19:42:06 INFO - PROCESS | 22654 | 19:42:09 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:42:09 INFO - PROCESS | 22654 | RSS: Main: 158404608 19:42:09 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60326/tests/kraken/driver.html?testName=ai-astar) 19:42:11 INFO - PROCESS | 22654 | RSS: Main: 160043008 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | __start_tp_report 19:42:11 INFO - PROCESS | 22654 | _x_x_mozilla_page_load 19:42:11 INFO - PROCESS | 22654 | _x_x_mozilla_page_load_details 19:42:11 INFO - PROCESS | 22654 | |i|pagename|runs| 19:42:11 INFO - PROCESS | 22654 | |0;ai-astar;113;109;111;111;115;122;111;112;113;111 19:42:11 INFO - PROCESS | 22654 | |1;audio-beat-detection;154;127;159;174;128;163;151;128;186;127 19:42:11 INFO - PROCESS | 22654 | |2;audio-dft;163;164;165;160;162;160;161;162;165;163 19:42:11 INFO - PROCESS | 22654 | |3;audio-fft;74;76;76;185;76;72;76;75;169;77 19:42:11 INFO - PROCESS | 22654 | |4;audio-oscillator;92;92;159;93;91;92;142;92;92;150 19:42:11 INFO - PROCESS | 22654 | |5;imaging-gaussian-blur;117;118;118;121;117;118;117;117;118;118 19:42:11 INFO - PROCESS | 22654 | |6;imaging-darkroom;146;149;147;147;150;146;147;148;147;147 19:42:11 INFO - PROCESS | 22654 | |7;imaging-desaturate;95;95;94;95;95;96;95;95;95;95 19:42:11 INFO - PROCESS | 22654 | |8;json-parse-financial;53;57;57;55;57;63;56;72;55;62 19:42:11 INFO - PROCESS | 22654 | |9;json-stringify-tinderbox;58;59;59;59;59;58;58;59;59;58 19:42:11 INFO - PROCESS | 22654 | |10;stanford-crypto-aes;82;75;73;73;73;74;75;76;74;75 19:42:11 INFO - PROCESS | 22654 | |11;stanford-crypto-ccm;120;123;121;128;121;125;120;120;156;120 19:42:11 INFO - PROCESS | 22654 | |12;stanford-crypto-pbkdf2;177;158;159;162;160;158;164;163;158;157 19:42:11 INFO - PROCESS | 22654 | |13;stanford-crypto-sha256-iterative;69;68;68;70;74;67;65;67;68;68 19:42:11 INFO - PROCESS | 22654 | __end_tp_report 19:42:11 INFO - PROCESS | 22654 | __start_cc_report 19:42:11 INFO - PROCESS | 22654 | _x_x_mozilla_cycle_collect,866 19:42:11 INFO - PROCESS | 22654 | __end_cc_report 19:42:11 INFO - PROCESS | 22654 | __startTimestamp1461984131709__endTimestamp 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | ------- Summary: start ------- 19:42:11 INFO - PROCESS | 22654 | Number of tests: 14 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.50 stddev:3.61 (3.2%) stddev-sans-first:3.83 19:42:11 INFO - PROCESS | 22654 | Values: 113.0 109.0 111.0 111.0 115.0 122.0 111.0 112.0 113.0 111.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:156.50 stddev:21.51 (13.7%) stddev-sans-first:22.76 19:42:11 INFO - PROCESS | 22654 | Values: 154.0 127.0 159.0 174.0 128.0 163.0 151.0 128.0 186.0 127.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 19:42:11 INFO - PROCESS | 22654 | Values: 163.0 164.0 165.0 160.0 162.0 160.0 161.0 162.0 165.0 163.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:43.09 (56.7%) stddev-sans-first:44.99 19:42:11 INFO - PROCESS | 22654 | Values: 74.0 76.0 76.0 185.0 76.0 72.0 76.0 75.0 169.0 77.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.47 (30.9%) stddev-sans-first:29.48 19:42:11 INFO - PROCESS | 22654 | Values: 92.0 92.0 159.0 93.0 91.0 92.0 142.0 92.0 92.0 150.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 19:42:11 INFO - PROCESS | 22654 | Values: 117.0 118.0 118.0 121.0 117.0 118.0 117.0 117.0 118.0 118.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.26 (0.9%) stddev-sans-first:1.24 19:42:11 INFO - PROCESS | 22654 | Values: 146.0 149.0 147.0 147.0 150.0 146.0 147.0 148.0 147.0 147.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:42:11 INFO - PROCESS | 22654 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:5.60 (9.8%) stddev-sans-first:5.55 19:42:11 INFO - PROCESS | 22654 | Values: 53.0 57.0 57.0 55.0 57.0 63.0 56.0 72.0 55.0 62.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 19:42:11 INFO - PROCESS | 22654 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 59.0 58.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.67 (3.6%) stddev-sans-first:1.09 19:42:11 INFO - PROCESS | 22654 | Values: 82.0 75.0 73.0 73.0 73.0 74.0 75.0 76.0 74.0 75.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.00 stddev:11.08 (9.1%) stddev-sans-first:11.58 19:42:11 INFO - PROCESS | 22654 | Values: 120.0 123.0 121.0 128.0 121.0 125.0 120.0 120.0 156.0 120.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.00 stddev:5.91 (3.7%) stddev-sans-first:2.52 19:42:11 INFO - PROCESS | 22654 | Values: 177.0 158.0 159.0 162.0 160.0 158.0 164.0 163.0 158.0 157.0 19:42:11 INFO - PROCESS | 22654 | 19:42:11 INFO - PROCESS | 22654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.37 (3.5%) stddev-sans-first:2.50 19:42:11 INFO - PROCESS | 22654 | Values: 69.0 68.0 68.0 70.0 74.0 67.0 65.0 67.0 68.0 68.0 19:42:11 INFO - PROCESS | 22654 | -------- Summary: end -------- 19:42:11 INFO - PROCESS | 22654 | 19:42:12 INFO - TEST-INFO | 22654: exit 0 19:42:12 INFO - TEST-OK | kraken | took 60978ms 19:42:12 INFO - SUITE-END | took 1170s 19:42:12 INFO - Completed test suite (00:19:30) 19:42:12 INFO - javascript benchmark 19:42:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.177205698575, 3366.1584603849037, 3398.7281017518603, 3422.435298175801, 3429.2455659754846, 5510.559155267579, 5510.9448905510935, 5522.088855338864, 5552.250446189768, 5562.110062390018, 5458.208559758833, 5517.5585953123755, 5547.362053363864, 5569.136783798507, 5572.080606699899, 5058.291839142523, 5061.3420255366755, 5095.439501654815, 5098.566621837148, 5120.385553733558, 5021.196608542616, 5136.58907287418, 5159.613029022819, 5228.08508511009, 5238.607104467161, 5018.64869459138, 5033.748312584375, 5042.672226305279, 5082.923756143661, 5178.637495375326, 5058.468860769622, 5063.544281014708, 5089.109405853961, 5110.105731496973, 5111.744412779383, 4884.023195360906, 4993.350864387643, 4998.6750861193905, 5011.398632164163, 5067.214581739836, 5397.27136836526, 5402.432744561804, 5423.457654234585, 5443.972780136074, 5456.48163424474, 5897.292324920994, 5919.674417907014, 5929.881402371929, 5937.465628093449, 5944.0, 5816.331121920991, 5956.52347812174, 5976.4919981801595, 5982.312034116088, 5996.790112346047, 5562.082256427685, 5570.442955704397, 5584.441555844423, 5590.0, 5602.047651899146, 6013.278406591149, 6027.939720602738, 6030.427109424598, 6040.124181993587, 6055.152278680988, 5729.885402292014, 5798.565107616945, 5799.18811366409, 5886.411358864079, 5911.4975227105315, 5850.502707269845, 5859.296884373903, 5859.44335288147, 5865.0, 5867.266591676041, 5779.624324418899, 5820.185174075633, 5825.1844741736195, 5836.649801011953, 5838.941610583925, 5727.0, 5889.057750759858, 5892.823215303548, 5921.348651648315, 5977.282726072899, 4475.977620111944, 4496.3255511673515, 4496.505384407713, 4511.210538155809, 4518.638508919278, 4009.7594144351433, 4044.919101617951, 4065.16664083868, 4065.57311482296, 4070.2673518766314, 5576.470235327637, 5734.0, 5781.566382521328, 5788.479036886701, 5796.101604251347, 5960.731767070492, 5961.195238642727, 5979.5515336349945, 5990.251218597676, 6013.789517366871, 5635.295588051494, 5748.971255143698, 5772.884542309131, 5779.133130030529, 5804.1293805929445, 5097.643164978416, 5102.668326558762, 5136.049830781242, 5155.6391052626705, 5183.170692689152, 6182.0, 6233.625982441068, 6238.532110091761, 6242.344553821874, 6256.31180570146, 5924.200232968494, 5997.190379298739, 6003.7898673546215, 6007.699615019232, 6023.096535519707, 6142.600730952474, 6157.907631385443, 6159.384061593805, 6165.660888651168, 6170.876582468236, 5818.738156782871, 5822.446867547576, 5825.2135961644635, 5841.649501029951, 5882.382349853375, 5916.674582897982, 5936.643801371932, 5951.166836642787, 6000.189974353407, 6020.1270815730595, 5752.9712351437975, 5789.913151302818, 5798.0, 5802.361740208489, 5807.477327040418, 5735.254416925773, 5763.164341170591, 5780.768769249351, 5804.65172089676, 5804.82585522435, 5553.72231388437, 5722.141678748221, 5807.186993820953, 5827.038538641246, 5842.503387212135, 5728.484436400744, 5775.971120144372, 5784.21913041734, 5790.305163380422, 5803.7968671096305, 5580.888382232251, 5659.971700141473, 5670.461306175906, 5670.546356291405, 5681.119426488901], "value": 5482.953765297885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.432881748791, 665.747016133869, 669.0900375489335, 669.34069941108, 669.5882032549983, 39367.0, 40222.79888600556, 40254.1949161017, 40413.59586404135, 40637.0, 42293.788531057304, 43273.56726432735, 43296.0, 43392.3491147633, 43563.0, 8786.384953053288, 8998.730038098867, 9019.684311049115, 9021.052789457111, 9031.683891063814, 8773.824523509526, 8890.599923003449, 8918.241949434307, 9174.770630734218, 9224.769380765467, 9193.494357810318, 9252.953735231315, 9270.536473176347, 9277.97942226358, 9284.257259419264, 9144.314176436794, 9180.495072770995, 9198.126178013112, 9246.029166937442, 9246.537673116318, 9086.45481271126, 9119.908800912039, 9129.954350228207, 9133.771655708593, 9185.954070229673, 44813.327800083025, 44926.10147797059, 45056.09887802258, 45074.32388514175, 45139.32291015638, 3939.409088636699, 3968.3650615901315, 3985.143194213258, 4019.457373254632, 4076.8369265229353, 33359.83320083408, 33517.6648233517, 33917.0, 34133.14667133317, 34275.14312142191, 4478.686491945565, 4594.287885377772, 4603.792829322689, 4633.096546173498, 4649.209634362132, 348697.0, 350107.0, 350406.0, 352243.0, 354910.0, 36599.81700091482, 62404.375956239855, 63743.76896808682, 63747.36252637414, 63772.36227637757, 36463.088422789646, 36615.26769464596, 36698.8165059173, 36731.81634091866, 36780.44829327562, 16965.745513817303, 16986.150692465326, 17226.741598876026, 17251.137443127795, 17278.13609319529, 14679.55961321162, 14692.706145877022, 14760.114393136446, 14787.556373308818, 14792.11247325164, 9428.434293942386, 9508.762280943032, 9519.476428796483, 9523.476208808443, 9539.0, 3528.1179705073732, 3615.1865830188, 3629.292288003814, 3664.4686520454384, 3677.705783537364, 1128.2046157458972, 1132.7143691909741, 1136.4374634555948, 1165.0737663557493, 1175.3770501634147, 33437.665623343455, 33440.832795835864, 33706.66293337084, 33996.150096247795, 34193.487097693556, 1202.939853007346, 1272.4210484229654, 1279.7440511897657, 1333.1334632488765, 1337.3781191745884, 17483.65032699339, 18049.877147433217, 18073.08372553127, 18074.548136296435, 18171.454856354332, 287837.0, 317310.0, 320754.0, 323385.0, 560629.0, 57050.0, 57844.71077644585, 58089.128663070085, 58204.0, 58380.41619583835, 1505.9849401506065, 1543.3055125193484, 1544.7219500489796, 1554.6890621875896, 1665.9920747947317, 31782.364352713277, 31811.20471988219, 32052.51921221137, 32696.673033269362, 32826.50760238646, 57057.714711426175, 57124.71437642785, 57280.71359643175, 57630.0, 57654.13518797305, 429021.0, 429830.0, 430091.0, 430264.0, 431852.0, 31123.84438077795, 31698.366032679678, 31706.0, 31777.046688599377, 41887.16225675408, 44876.55123448724, 45659.0, 45965.540344597466, 46062.07875842397, 46533.06933861371, 38857.80571097126, 38873.61126388813, 39594.80202598969, 39984.40023399593, 41122.0, 42891.0, 43044.923876903325, 43222.351664725684, 43718.78140609276, 43736.0, 42230.15539689128, 42860.57139428566, 43115.56884431116, 43513.78243108764, 44708.32937505875, 37221.813890930374, 37367.62632373641, 37552.2489550202, 38320.6167938317, 38435.0, 28655.426891461637, 29302.0, 29613.407731845673, 29676.0, 29821.254468638457], "value": 19685.86213254672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.88590637574663, 423.4600883873063, 423.9130978149479, 425.1709167124107, 427.89944363074693, 18603.62792744146, 18758.0, 19248.615027699456, 19569.31507397238, 19943.60112797747, 19099.904500477478, 19611.705824412646, 19760.802391976074, 19836.504087397785, 19888.502787430323, 5135.204043373274, 5433.510984011438, 5466.972665136669, 5490.094134467828, 5493.038718224315, 4157.085441202946, 5420.214068959998, 5491.203775452557, 5838.591298609099, 6152.261728592553, 6088.4215999479975, 6108.572399932006, 6126.142340072372, 6138.14066030756, 6141.263048434194, 5844.912326315088, 6100.450959413674, 6104.542159338067, 6108.511319094484, 6112.113743507211, 5768.653880767126, 5864.1203819427, 5924.229850119457, 5924.7926322578505, 5926.614770039933, 14922.70154596902, 15180.696386072326, 15204.771928421083, 15261.847381526153, 21561.0, 2374.1927744566756, 2375.762423757628, 2467.987660061688, 2472.7527247275307, 2483.130904183521, 10430.478476076165, 10473.214508911862, 10861.565537378574, 10908.563657453693, 11225.326480411202, 2066.0909199951975, 2082.354470114254, 2123.2674727219087, 2148.5702859428175, 2150.064721846002, 80613.0, 81926.59036704779, 83106.0, 84948.57525712332, 86664.5666771662, 11166.385848778395, 11554.364509951865, 11677.240979336317, 11926.473148770026, 12361.196522226026, 16670.249838757285, 16679.416220432227, 16806.243719032675, 16843.494695159166, 16889.91555042217, 9071.319651026199, 9146.54267286633, 9156.404833685789, 9360.11078947499, 9372.390794598467, 8765.868511972325, 8837.690680826141, 8928.419652722552, 9091.49654284527, 9222.815543689088, 5042.924356134661, 5062.0, 5067.189249720027, 5158.638895277295, 5188.247704082887, 1890.0738638067523, 2086.9582608347746, 2107.346722516025, 2147.914083436645, 2163.307741522729, 1012.3116280928891, 1098.9285696429706, 1100.1968562948932, 1219.1344145656506, 1238.1147479552164, 19084.332048378517, 19542.12060457283, 19742.506437338896, 19950.800491994894, 20024.49938751543, 1081.1729027294127, 1124.6850881753123, 1161.9941900290614, 1162.5349860055876, 1209.3227792436264, 10777.83833242502, 11184.0, 11227.101831853432, 11243.325400475998, 11269.943650281695, 388734.0, 389961.0, 390340.0, 396119.0, 528855.0, 95500.52249738846, 97082.51458742803, 101997.0, 102188.0, 109575.0, 1132.8640563132476, 1150.1316506037888, 1173.266708307308, 1180.3036208636945, 1180.5963755193177, 17781.377651782124, 18183.45449636513, 18240.72638910444, 18299.634007319513, 18352.357667481574, 40615.0, 41024.0, 41661.0, 42473.0, 42869.356959646255, 57275.42724572701, 58015.0, 59349.0, 59353.0, 59592.404075958686, 8682.0, 8789.516576588348, 8798.736037918872, 9077.45535267886, 9130.132637399436, 10233.897661023295, 13739.175649461064, 13842.584722458343, 13920.58238252854, 14180.574582762534, 11649.475773590038, 12487.250764954131, 12493.0, 12505.437255323714, 12579.308138052129, 11693.0, 11943.641690749291, 12236.816447753114, 12308.199967002116, 12369.752604948031, 12511.12422130442, 12553.748925021266, 12576.622701318975, 12694.809577856155, 12808.615741527396, 8631.654733810828, 8711.477311361085, 8815.735527934172, 8865.64537418496, 8942.37403381757, 11681.182317237712, 12027.819582706092, 12230.327331996825, 12286.75426491483, 12615.116941813985], "value": 9562.30069165262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1617.1348328644178, 1650.9174541272937, 1836.559225785811, 1892.6120145370191, 1893.5266183454137, 7434.553926764384, 8009.759707208786, 8041.396895232851, 8190.05814331352, 8235.752927412179, 8054.315383192436, 8087.433879628428, 8132.227438393358, 8140.755777326674, 8171.142030086845, 2344.742078371382, 2369.656399822025, 2378.9286321410386, 2381.30942026812, 2383.392234980078, 2340.32130682102, 2358.587247231736, 2373.9881300593474, 2402.231285988484, 2405.2183040511904, 2308.53829234153, 2343.425860664131, 2344.284993077111, 2385.0340612052146, 2389.7490763469846, 2241.68616393705, 2247.325802259316, 2261.683364328995, 2262.1403866530613, 2265.660150977358, 2227.3095340444515, 2253.7746225377496, 2260.0, 2261.739899911515, 2268.727752669674, 8193.180681931819, 8240.093589705128, 8298.751037468825, 8318.12659670732, 8338.291245244161, 4994.550490455877, 5164.25118357836, 5184.429712731597, 5191.299174611417, 5195.584353251731, 3150.8582113804932, 3184.283536204359, 3304.8182349970743, 3360.41192791263, 3367.2087059540986, 1016.293675895253, 1019.1642852860657, 1020.4234607446768, 1034.3793723765755, 1048.895110488945, 11189.832152517718, 11218.719532011683, 11348.943255283753, 11456.599019034376, 11465.942670286595, 4568.931466028012, 4583.106294272585, 4654.604358629486, 4671.5328467153695, 4707.458642256116, 9507.429554226768, 9584.472853992958, 9636.566354514063, 9654.372465789702, 9834.704958851245, 5171.3018742469285, 5241.0828105081455, 5251.186066159751, 5253.238280449314, 5277.551408130275, 4223.5565265646665, 4674.579287864109, 4721.6694831362165, 4841.927371089437, 4847.709137451764, 3887.8833634990997, 3918.1575961168487, 3962.663173630274, 4014.3376342903093, 4189.0574620710095, 1283.4994352202648, 1284.9550265740654, 1291.341415877909, 1294.7345794112184, 1312.330711337206, 936.2042264075482, 999.2954966748425, 1010.8483727440796, 1065.738893970982, 1081.1404933078222, 5969.970150149222, 6036.728347224385, 6071.574989750763, 6114.0, 6255.812325630239, 1005.4470041477158, 1068.4978060311641, 1069.2034434346463, 1075.4353964168874, 1080.8756992945755, 4072.6945479089186, 4284.207421626947, 4290.892727681833, 4305.74165550068, 4369.104333611602, 9932.702018939442, 10072.546735396925, 10143.949280253699, 10151.492425378849, 10156.085952264331, 9551.808963820684, 9904.900950990543, 10213.948930255301, 10238.385696858213, 10290.382577045251, 7750.5737184454265, 7854.764357069297, 7862.095858976177, 7874.370050395954, 7934.404919630935, 5732.656040637575, 5815.331236907809, 5941.494972927177, 5969.283685957713, 6003.6397816131175, 9431.198348140484, 9579.233661307218, 9616.749822523027, 9671.17794987434, 9704.0, 9428.622855085994, 9525.761855953378, 9527.714168574954, 9800.607975681178, 9819.85270220933, 6939.132608423947, 7362.190159082604, 7389.519681220703, 7642.617869106633, 7646.082470103624, 7994.320482759031, 7999.840003199787, 8006.159353268056, 8104.2300981409035, 8130.837383252184, 7321.560706357635, 7405.703771849281, 7444.478886478111, 7449.962750186214, 7487.47587668858, 7236.167840698387, 7245.746398876014, 7287.489875708649, 7339.486235963432, 7421.406287497095, 6643.435307998681, 6647.800565983028, 6664.733410663519, 6692.330766923269, 6718.428933540704, 5243.213517972335, 5294.497022782984, 5334.51989320963, 5392.892142157213, 5483.122700367922, 5466.125419932791, 5527.364353099445, 5535.529479994246, 5554.611177217556, 5583.609147359646], "value": 4565.845848887547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.6463348850219, 340.98124603146834, 344.49015457123454, 350.61782656903983, 353.63222248861183, 5609.70002299057, 5753.194552762617, 5756.913646295304, 5790.478856902878, 5822.184894114827, 5639.971800141004, 5640.971795141018, 5644.887102257952, 5654.180143879145, 5670.4896559309655, 4198.412222288875, 4261.318189089746, 4395.120975804836, 4426.048399594087, 4447.84432544861, 4362.781860906958, 4436.64506839452, 4452.265376212921, 4456.6880318377725, 4467.7542735149555, 4366.912661746779, 4412.338149277618, 4433.623142032931, 4434.667399945001, 4443.466783985927, 4322.783860806962, 4392.560743925614, 4402.295632698753, 4427.1367083418745, 4434.157510073108, 3877.9806100969595, 3879.8254078566533, 3920.157166209279, 3925.509311336083, 3936.8031598420253, 5419.078756611386, 5450.781968721247, 5461.5357694596005, 5465.147071314714, 5516.862078448031, 4952.87617809554, 5087.313212716273, 5091.872703182413, 5105.438401775802, 5129.3075434816565, 5780.797672081457, 5862.9153606582495, 5905.43898329658, 5929.703514824285, 5939.524838012949, 4299.871003869889, 4335.219660461115, 4338.175746608166, 4343.913121737579, 4352.869413917588, 6053.061775424816, 6058.606190597597, 6126.540509461764, 6210.937890621126, 6219.657918814463, 4414.933775993362, 4415.161119387306, 4426.919347906479, 4446.221911165533, 4447.911041779146, 4473.1277400907165, 4481.887952801141, 4483.820647174141, 4488.955110448919, 4492.3710680504755, 4894.486078961729, 5051.949480505148, 5071.0, 5077.1876499759865, 5086.135356989321, 5932.495737862244, 5964.850878728066, 5973.283206015306, 6019.247594050744, 6023.969880150571, 1499.482678475924, 1612.0, 1641.7209074457132, 1659.31138577489, 1664.4257731082757, 1000.1898462245459, 1032.6437379104198, 1050.1598721023151, 1051.279873286801, 1062.7874425115008, 6218.9378106219265, 6221.4089661482085, 6227.283862355796, 6266.185395898504, 6280.748770049238, 6555.475561955032, 6563.1796025496815, 6564.326096845274, 6611.140551728341, 6615.140031795836, 5716.685582293014, 5957.851053723692, 6030.5778595497895, 6031.2159419276095, 6046.516278697693, 3582.659647333499, 3584.068142282973, 3596.694280986093, 3604.6034936157002, 3610.4764809102535, 6212.72042758077, 6492.480601551959, 6508.056331831858, 6544.836379090466, 7014.368706816309, 6366.872662546816, 6369.172007638977, 6383.585066970632, 6406.839829004219, 6427.164468619049, 6299.338569450233, 6500.562289141572, 6506.707198176094, 6514.185726784152, 6561.967190164019, 6170.907436388368, 6228.660837919869, 6266.404691554295, 6284.183056202664, 6311.0, 5938.732757025858, 6194.26560563043, 6205.81382558524, 6217.197012866218, 6228.377162283736, 6517.0, 6538.705758240986, 6542.509311801729, 6549.901751473827, 6550.541462097798, 4227.1123064155645, 4248.596383343577, 4270.893227669333, 4296.548862369406, 4300.3549467580115, 6181.84545386369, 6233.937660623335, 6256.874862502816, 6308.432241098323, 6323.873522529616, 6121.112438696275, 6132.46688327918, 6140.938590614215, 6145.72344244519, 6165.722542485689, 5893.145493903446, 5992.310884248192, 5995.520358371233, 6085.4523092921845, 6101.328853826164, 5831.504322132666, 5945.721669841005, 5976.133460648269, 5994.790182343597, 6015.789447369321, 6039.6678182698615, 6062.666553339609, 6073.878522429615, 6125.9693701531205, 6160.106784516131, 5682.5453963681975, 5914.615549989237, 5928.525717942641, 5959.851003724768, 5979.252593425822], "value": 4629.003185484856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.3662833105184, 817.0685418622769, 818.3289702443998, 827.288531862598, 850.4387104511025, 14980.775288370683, 15051.322690478928, 15187.696246075071, 15233.542993710178, 15358.923205383986, 14334.42662293507, 14383.208923509203, 14421.855781442182, 14433.0, 14439.0, 883.5670521444478, 901.3420203251646, 928.7631653928239, 935.9017303183169, 939.6899023322321, 924.653255029364, 934.1685899549373, 935.4247138010143, 936.0312077000306, 941.223490620241, 960.4381436859411, 962.4946902876011, 962.8603852441391, 966.830804609194, 973.1047436358532, 955.4267439536292, 956.4643799472283, 957.5020989085637, 959.7504648791295, 966.7099870038995, 706.8374273917028, 707.9292070792931, 711.7117567385217, 712.4087007783527, 712.7006657203935, 16417.83582164175, 16422.0, 16430.507084787474, 16462.42381516641, 16491.257893394704, 13354.198748075049, 13989.860101398957, 14416.279186040656, 14444.422223111063, 14468.0, 12380.133390662657, 12408.193467424679, 12458.439370228361, 12517.248965062125, 12705.428255728515, 3930.7051971102283, 4004.6395824375654, 4005.2790497710403, 4008.6793056555407, 4032.6169013943627, 56618.71690641562, 57596.71201644007, 58186.99999999958, 58202.70898645522, 58528.41471585272, 11676.357800320893, 11696.88303116958, 11730.237534560227, 12071.3360765157, 12085.577004804789, 20212.29256975999, 20559.177632894814, 20622.484437889172, 20646.690299645517, 20703.689444658343, 8382.916170838214, 8443.0, 8487.830243395098, 8522.57387130641, 8543.487390756574, 4803.711777293303, 5008.0, 5048.167052436307, 5078.644494885397, 5193.091209038404, 3566.518519999767, 3596.1009747563107, 3600.0279924420784, 3600.4059330210744, 3610.891673249807, 609.8993666045142, 611.9418655227746, 615.0681717198358, 621.1459243540132, 626.2766504687094, 741.3587247031279, 751.3538357012965, 781.261707686231, 829.9792505187298, 843.0768308701962, 10000.949995249977, 10732.463376831127, 10755.83866242007, 10824.567017319376, 10864.945675271572, 794.7973266816924, 798.9201079892081, 833.3874602167402, 836.0677844203669, 836.5858899844494, 4505.324201369821, 4615.607673347803, 4619.260918253063, 4626.421697287839, 4718.669693121448, 62249.37750622526, 64470.67764661147, 67660.0, 68426.0, 70184.29815701778, 54659.0, 55642.72178639081, 57565.424345756845, 58443.70778146082, 59045.40954590399, 54796.0, 55241.862974285425, 55309.99999999919, 55429.44570554243, 55879.44120558743, 9857.901420985698, 9898.0, 9949.950250248703, 10020.56774937161, 10163.695089147337, 35147.121321967155, 35586.04276764699, 35599.28801424009, 35854.64145358513, 35923.46114808332, 49461.258081129534, 49770.25344619761, 49809.50190498048, 50091.74954125352, 50159.74920125376, 12153.69615759613, 12306.261624302571, 12363.93818030904, 12427.937860311002, 12516.374181291081, 12494.0, 13041.543545975845, 13964.441422342992, 14187.574372768833, 15378.615534611725, 13011.414486347947, 13593.59219223425, 13726.725465490834, 14501.637459063608, 14816.036957597722, 13090.738185236052, 13355.0, 13538.0, 13965.860341396456, 14278.0, 14174.0, 14219.289035547974, 14370.425182992563, 14420.783688244475, 14793.408263669333, 11699.2980421175, 11818.113641476752, 11878.703032424259, 12116.843476272285, 12319.795515462949, 12190.2076365036, 12357.93821030889, 12384.62846114618, 12443.875561244271, 12495.0], "value": 7313.922794673567, "unit": "score"}], "name": "dromaeo_css", "value": 7364.703750055509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 111.0, 111.0, 115.0, 122.0, 111.0, 112.0, 113.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 159.0, 174.0, 128.0, 163.0, 151.0, 128.0, 186.0, 127.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 160.0, 162.0, 160.0, 161.0, 162.0, 165.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 185.0, 76.0, 72.0, 76.0, 75.0, 169.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 159.0, 93.0, 91.0, 92.0, 142.0, 92.0, 92.0, 150.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 121.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 147.0, 150.0, 146.0, 147.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 57.0, 55.0, 57.0, 63.0, 56.0, 72.0, 55.0, 62.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 73.0, 73.0, 73.0, 74.0, 75.0, 76.0, 74.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 121.0, 128.0, 121.0, 125.0, 120.0, 120.0, 156.0, 120.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 158.0, 159.0, 162.0, 160.0, 158.0, 164.0, 163.0, 158.0, 157.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 70.0, 74.0, 67.0, 65.0, 67.0, 68.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1538.1, "alertThreshold": 2.0}]} 19:42:12 INFO - Return code: 0 19:42:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:42:13 ERROR - # TBPL SUCCESS # 19:42:13 INFO - Running post-action listener: _resource_record_post_action 19:42:13 INFO - Running post-run listener: _resource_record_post_run 19:42:14 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 498978816; Read time: 36; Write time: 320780 19:42:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 195817472; Read time: 0; Write time: 165920 19:42:14 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250183680; Read time: 36; Write time: 136704 19:42:14 INFO - Running post-run listener: _upload_blobber_files 19:42:14 INFO - Blob upload gear active. 19:42:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:42:14 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:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:42:14 INFO - (blobuploader) - INFO - Open directory for files ... 19:42:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:42:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:15 INFO - (blobuploader) - INFO - Done attempting. 19:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:42:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:16 INFO - (blobuploader) - INFO - Done attempting. 19:42:16 INFO - (blobuploader) - INFO - Iteration through files over. 19:42:16 INFO - Return code: 0 19:42:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:42:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:42:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e636821f3eb99d1ba05d8536c5133ff5aab91403a873d86da69d555e4379db1332be280d7bc007902597bfb1d54087752f29052306429022b7ba08225582feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ea37a75b084a05322c0f32468a7b512cde71b20ab9a225736c3540b3934219a0c1917604401554a95af4ae69092df081de199dbdbbc5721f68286233dacf724"} 19:42:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:42:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:42:16 INFO - Contents: 19:42:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e636821f3eb99d1ba05d8536c5133ff5aab91403a873d86da69d555e4379db1332be280d7bc007902597bfb1d54087752f29052306429022b7ba08225582feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ea37a75b084a05322c0f32468a7b512cde71b20ab9a225736c3540b3934219a0c1917604401554a95af4ae69092df081de199dbdbbc5721f68286233dacf724"} 19:42:16 INFO - Running post-run listener: copy_logs_to_upload_dir 19:42:16 INFO - Copying logs to upload dir... 19:42:16 INFO - mkdir: /builds/slave/test/build/upload/logs 19:42:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.407456 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-29 19:42:16.103706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 19:42:16.107629) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e636821f3eb99d1ba05d8536c5133ff5aab91403a873d86da69d555e4379db1332be280d7bc007902597bfb1d54087752f29052306429022b7ba08225582feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ea37a75b084a05322c0f32468a7b512cde71b20ab9a225736c3540b3934219a0c1917604401554a95af4ae69092df081de199dbdbbc5721f68286233dacf724"} build_url:https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/P5Pye_kWT0qsBiNXNWZCag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e636821f3eb99d1ba05d8536c5133ff5aab91403a873d86da69d555e4379db1332be280d7bc007902597bfb1d54087752f29052306429022b7ba08225582feeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ea37a75b084a05322c0f32468a7b512cde71b20ab9a225736c3540b3934219a0c1917604401554a95af4ae69092df081de199dbdbbc5721f68286233dacf724"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 19:42:16.132796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:42:16.133139) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461980883.804412-188168848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 19:42:16.217282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 19:42:16.217656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 19:42:16.218003) ========= ========= Total master_lag: 1.09 =========