builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1463658289.03 results: success (0) buildid: 20160519020753 builduid: 645d9f387ec84ae0b97b9b613d199be1 revision: ca41d290daa081865b50f2434aabe15c9fd7ae66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.026009) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.026513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.026845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.061302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.061600) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 04:44:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.8M=0s 2016-05-19 04:44:49 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.165478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.165859) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.223584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.223961) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ca41d290daa081865b50f2434aabe15c9fd7ae66 --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 ca41d290daa081865b50f2434aabe15c9fd7ae66 --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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 04:44:49,975 truncating revision to first 12 chars 2016-05-19 04:44:49,975 Setting DEBUG logging. 2016-05-19 04:44:49,975 attempt 1/10 2016-05-19 04:44:49,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ca41d290daa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 04:44:50,252 unpacking tar archive at: mozilla-aurora-ca41d290daa0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.831280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.831640) ========= script_repo_revision: ca41d290daa081865b50f2434aabe15c9fd7ae66 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.832149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.832457) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:49.840397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 04:44:49.840731) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:50 INFO - MultiFileLogger online at 20160519 04:44:50 in /builds/slave/test 04:44:50 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 04:44:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:50 INFO - {'append_to_log': False, 04:44:50 INFO - 'base_work_dir': '/builds/slave/test', 04:44:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:44:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:50 INFO - 'branch': 'Mozilla-Aurora', 04:44:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:50 INFO - 'config_files': ('talos/linux_config.py',), 04:44:50 INFO - 'default_actions': ('clobber', 04:44:50 INFO - 'read-buildbot-config', 04:44:50 INFO - 'download-and-extract', 04:44:50 INFO - 'populate-webroot', 04:44:50 INFO - 'create-virtualenv', 04:44:50 INFO - 'install', 04:44:50 INFO - 'run-tests'), 04:44:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:50 INFO - 'download_minidump_stackwalk': True, 04:44:50 INFO - 'download_symbols': 'ondemand', 04:44:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:50 INFO - 'installer_path': 'installer.exe', 04:44:50 INFO - 'log_level': 'info', 04:44:50 INFO - 'log_name': 'talos', 04:44:50 INFO - 'log_to_console': True, 04:44:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:50 INFO - 'opt_config_files': (), 04:44:50 INFO - 'pip_index': False, 04:44:50 INFO - 'sps_profile': False, 04:44:50 INFO - 'sps_profile_interval': 0, 04:44:50 INFO - 'suite': 'dromaeojs-e10s', 04:44:50 INFO - 'system_bits': '32', 04:44:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:50 INFO - 'title': 'talos-linux64-ix-067', 04:44:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:50 INFO - 'use_talos_json': True, 04:44:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:50 INFO - 'work_dir': 'build'} 04:44:50 INFO - ##### 04:44:50 INFO - ##### Running clobber step. 04:44:50 INFO - ##### 04:44:50 INFO - Running pre-action listener: _resource_record_pre_action 04:44:50 INFO - Running main action method: clobber 04:44:50 INFO - rmtree: /builds/slave/test/build 04:44:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:51 INFO - Running post-action listener: _resource_record_post_action 04:44:51 INFO - ##### 04:44:51 INFO - ##### Running read-buildbot-config step. 04:44:51 INFO - ##### 04:44:51 INFO - Running pre-action listener: _resource_record_pre_action 04:44:51 INFO - Running main action method: read_buildbot_config 04:44:51 INFO - Using buildbot properties: 04:44:51 INFO - { 04:44:51 INFO - "project": "", 04:44:51 INFO - "product": "firefox", 04:44:51 INFO - "script_repo_revision": "production", 04:44:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:44:51 INFO - "repository": "", 04:44:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:44:51 INFO - "buildid": "20160519020753", 04:44:51 INFO - "pgo_build": "True", 04:44:51 INFO - "basedir": "/builds/slave/test", 04:44:51 INFO - "buildnumber": 361, 04:44:51 INFO - "slavename": "talos-linux64-ix-067", 04:44:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:44:51 INFO - "platform": "ubuntu64_hw", 04:44:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:44:51 INFO - "branch": "mozilla-aurora", 04:44:51 INFO - "repo_path": "releases/mozilla-aurora", 04:44:51 INFO - "revision": "ca41d290daa081865b50f2434aabe15c9fd7ae66", 04:44:51 INFO - "stage_platform": "linux64-pgo", 04:44:51 INFO - "builduid": "645d9f387ec84ae0b97b9b613d199be1", 04:44:51 INFO - "slavebuilddir": "test" 04:44:51 INFO - } 04:44:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:44:51 INFO - Running post-action listener: _resource_record_post_action 04:44:51 INFO - ##### 04:44:51 INFO - ##### Running download-and-extract step. 04:44:51 INFO - ##### 04:44:51 INFO - Running pre-action listener: _resource_record_pre_action 04:44:51 INFO - Running main action method: download_and_extract 04:44:51 INFO - mkdir: /builds/slave/test/build/tests 04:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:51 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:44:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:44:54 INFO - Downloaded 1361 bytes. 04:44:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:54 INFO - Using the following test package requirements: 04:44:54 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:44:54 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:54 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:44:54 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'jsshell-linux-x86_64.zip'], 04:44:54 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:54 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:44:54 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:44:54 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:44:54 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:54 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:54 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:54 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:54 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:44:56 INFO - Downloaded 23813106 bytes. 04:44:56 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'] 04:44:56 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 04:44:57 INFO - Return code: 0 04:44:57 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 04:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:57 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:45:02 INFO - Downloaded 23813106 bytes. 04:45:02 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'] 04:45:02 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 04:45:03 INFO - Return code: 0 04:45: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')]} 04:45:03 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:45:04 INFO - Downloaded 10840145 bytes. 04:45:04 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'] 04:45:04 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 04:45:04 INFO - Return code: 0 04:45: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')]} 04:45:04 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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 04:45:10 INFO - Downloaded 62716570 bytes. 04:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:45:10 INFO - mkdir: /builds/slave/test/properties 04:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:10 INFO - Contents: 04:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:45:11 INFO - Running post-action listener: _resource_record_post_action 04:45:11 INFO - Running post-action listener: set_extra_try_arguments 04:45:11 INFO - ##### 04:45:11 INFO - ##### Running populate-webroot step. 04:45:11 INFO - ##### 04:45:11 INFO - Running pre-action listener: _resource_record_pre_action 04:45:11 INFO - Running main action method: populate_webroot 04:45:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:11 INFO - '--tppagecycles', 04:45:11 INFO - '7'], 04:45:11 INFO - 'tests': ['tsvgm']}}, 04:45:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['damp', 'tps']}, 04:45:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'tests': ['damp', 'tps']}, 04:45:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['dromaeo_dom']}, 04:45:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['a11yr', 04:45:11 INFO - 'ts_paint', 04:45:11 INFO - 'tpaint', 04:45:11 INFO - 'sessionrestore', 04:45:11 INFO - 'sessionrestore_no_auto_restore', 04:45:11 INFO - 'tabpaint']}, 04:45:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['tsvgx', 04:45:11 INFO - 'tsvgr_opacity', 04:45:11 INFO - 'tart', 04:45:11 INFO - 'tscrollx', 04:45:11 INFO - 'cart']}, 04:45:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:11 INFO - 'tsvgr_opacity', 04:45:11 INFO - 'tart', 04:45:11 INFO - 'tscrollx', 04:45:11 INFO - 'cart']}, 04:45:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'talos_options': ['--disable-e10s'], 04:45:11 INFO - 'tests': ['tp5o']}, 04:45:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'tests': ['tp5o']}, 04:45:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'talos_options': ['--disable-e10s', 04:45:11 INFO - '--xperf_path', 04:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:11 INFO - 'tests': ['tp5n']}, 04:45:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:11 INFO - 'talos_options': ['--xperf_path', 04:45:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:11 INFO - 'tests': ['tp5n']}}, 04:45:11 INFO - 'talos.zip': {'path': '', 04:45:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:11 INFO - Running post-action listener: _resource_record_post_action 04:45:11 INFO - ##### 04:45:11 INFO - ##### Running create-virtualenv step. 04:45:11 INFO - ##### 04:45:11 INFO - Running pre-action listener: _resource_record_pre_action 04:45:11 INFO - Running main action method: create_virtualenv 04:45:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:11 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 04:45:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:11 INFO - Using real prefix '/usr' 04:45:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:14 INFO - Installing pip.................done. 04:45:14 INFO - Return code: 0 04:45:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:14 INFO - Using env: {'DISPLAY': ':0', 04:45:14 INFO - 'HOME': '/home/cltbld', 04:45:14 INFO - 'LANG': 'en_US.UTF-8', 04:45:14 INFO - 'LANGUAGE': 'en_US:en', 04:45:14 INFO - 'LOGNAME': 'cltbld', 04:45:14 INFO - 'MAIL': '/var/mail/cltbld', 04:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:14 INFO - 'MOZ_NO_REMOTE': '1', 04:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:14 INFO - 'NO_EM_RESTART': '1', 04:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:14 INFO - 'PWD': '/builds/slave/test', 04:45:14 INFO - 'SHELL': '/bin/bash', 04:45:14 INFO - 'SHLVL': '1', 04:45:14 INFO - 'TERM': 'linux', 04:45:14 INFO - 'TMOUT': '86400', 04:45:14 INFO - 'USER': 'cltbld', 04:45:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:14 INFO - '_': '/tools/buildbot/bin/python'} 04:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:14 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 04:45:14 INFO - Cleaning up... 04:45:14 INFO - Return code: 0 04:45:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:45:14 INFO - Using env: {'DISPLAY': ':0', 04:45:14 INFO - 'HOME': '/home/cltbld', 04:45:14 INFO - 'LANG': 'en_US.UTF-8', 04:45:14 INFO - 'LANGUAGE': 'en_US:en', 04:45:14 INFO - 'LOGNAME': 'cltbld', 04:45:14 INFO - 'MAIL': '/var/mail/cltbld', 04:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:14 INFO - 'MOZ_NO_REMOTE': '1', 04:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:14 INFO - 'NO_EM_RESTART': '1', 04:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:14 INFO - 'PWD': '/builds/slave/test', 04:45:14 INFO - 'SHELL': '/bin/bash', 04:45:14 INFO - 'SHLVL': '1', 04:45:14 INFO - 'TERM': 'linux', 04:45:14 INFO - 'TMOUT': '86400', 04:45:14 INFO - 'USER': 'cltbld', 04:45:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:14 INFO - '_': '/tools/buildbot/bin/python'} 04:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:14 INFO - Downloading/unpacking psutil>=0.7.1 04:45:14 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 04:45:14 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 04:45:14 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 04:45:14 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 04:45:14 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 04:45:14 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 04:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:16 INFO - Installing collected packages: psutil 04:45:16 INFO - Running setup.py install for psutil 04:45:16 INFO - building 'psutil._psutil_linux' extension 04:45:16 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 04:45:16 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 04:45:16 INFO - building 'psutil._psutil_posix' extension 04:45:16 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 04:45:16 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 04:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:17 INFO - Successfully installed psutil 04:45:17 INFO - Cleaning up... 04:45:17 INFO - Return code: 0 04:45:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:45:17 INFO - Using env: {'DISPLAY': ':0', 04:45:17 INFO - 'HOME': '/home/cltbld', 04:45:17 INFO - 'LANG': 'en_US.UTF-8', 04:45:17 INFO - 'LANGUAGE': 'en_US:en', 04:45:17 INFO - 'LOGNAME': 'cltbld', 04:45:17 INFO - 'MAIL': '/var/mail/cltbld', 04:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:17 INFO - 'MOZ_NO_REMOTE': '1', 04:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:17 INFO - 'NO_EM_RESTART': '1', 04:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:17 INFO - 'PWD': '/builds/slave/test', 04:45:17 INFO - 'SHELL': '/bin/bash', 04:45:17 INFO - 'SHLVL': '1', 04:45:17 INFO - 'TERM': 'linux', 04:45:17 INFO - 'TMOUT': '86400', 04:45:17 INFO - 'USER': 'cltbld', 04:45:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:17 INFO - '_': '/tools/buildbot/bin/python'} 04:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:45:19 INFO - Installing collected packages: mozsystemmonitor 04:45:19 INFO - Running setup.py install for mozsystemmonitor 04:45:19 INFO - Successfully installed mozsystemmonitor 04:45:19 INFO - Cleaning up... 04:45:19 INFO - Return code: 0 04:45:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', '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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:45: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 blobuploader==1.2.4 04:45:19 INFO - Using env: {'DISPLAY': ':0', 04:45:19 INFO - 'HOME': '/home/cltbld', 04:45:19 INFO - 'LANG': 'en_US.UTF-8', 04:45:19 INFO - 'LANGUAGE': 'en_US:en', 04:45:19 INFO - 'LOGNAME': 'cltbld', 04:45:19 INFO - 'MAIL': '/var/mail/cltbld', 04:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:19 INFO - 'MOZ_NO_REMOTE': '1', 04:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:19 INFO - 'NO_EM_RESTART': '1', 04:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:19 INFO - 'PWD': '/builds/slave/test', 04:45:19 INFO - 'SHELL': '/bin/bash', 04:45:19 INFO - 'SHLVL': '1', 04:45:19 INFO - 'TERM': 'linux', 04:45:19 INFO - 'TMOUT': '86400', 04:45:19 INFO - 'USER': 'cltbld', 04:45:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:19 INFO - '_': '/tools/buildbot/bin/python'} 04:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:22 INFO - Downloading docopt-0.6.1.tar.gz 04:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:22 INFO - Running setup.py install for blobuploader 04:45:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:22 INFO - Running setup.py install for requests 04:45:22 INFO - Running setup.py install for docopt 04:45:22 INFO - Successfully installed blobuploader requests docopt 04:45:22 INFO - Cleaning up... 04:45:22 INFO - Return code: 0 04:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:22 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 04:45:22 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 04:45:22 INFO - Using env: {'DISPLAY': ':0', 04:45:22 INFO - 'HOME': '/home/cltbld', 04:45:22 INFO - 'LANG': 'en_US.UTF-8', 04:45:22 INFO - 'LANGUAGE': 'en_US:en', 04:45:22 INFO - 'LOGNAME': 'cltbld', 04:45:22 INFO - 'MAIL': '/var/mail/cltbld', 04:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:22 INFO - 'MOZ_NO_REMOTE': '1', 04:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:22 INFO - 'NO_EM_RESTART': '1', 04:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:22 INFO - 'PWD': '/builds/slave/test', 04:45:22 INFO - 'SHELL': '/bin/bash', 04:45:22 INFO - 'SHLVL': '1', 04:45:22 INFO - 'TERM': 'linux', 04:45:22 INFO - 'TMOUT': '86400', 04:45:22 INFO - 'USER': 'cltbld', 04:45:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:22 INFO - '_': '/tools/buildbot/bin/python'} 04:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:23 INFO - Running setup.py (path:/tmp/pip-OR2Pxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:23 INFO - Running setup.py (path:/tmp/pip-_otQ1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:23 INFO - Running setup.py (path:/tmp/pip-VYQ1nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:23 INFO - Running setup.py (path:/tmp/pip-5q0y4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:23 INFO - Running setup.py (path:/tmp/pip-lk3j7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:23 INFO - Running setup.py (path:/tmp/pip-Phrxz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:23 INFO - Running setup.py (path:/tmp/pip-rjfZI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:23 INFO - Running setup.py (path:/tmp/pip-ECQQyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:23 INFO - Running setup.py (path:/tmp/pip-yiEZor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:23 INFO - Running setup.py (path:/tmp/pip-0EU_DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:23 INFO - Running setup.py (path:/tmp/pip-71bHIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:23 INFO - Running setup.py (path:/tmp/pip-tWEZjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:24 INFO - Running setup.py (path:/tmp/pip-oAt3IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:24 INFO - Running setup.py (path:/tmp/pip-FnFMVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:24 INFO - Running setup.py (path:/tmp/pip-c5HrX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:24 INFO - Running setup.py (path:/tmp/pip-PRItpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:24 INFO - Running setup.py (path:/tmp/pip-Dp8M4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:24 INFO - Running setup.py install for manifestparser 04:45:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:24 INFO - Running setup.py install for mozcrash 04:45:24 INFO - Running setup.py install for mozdebug 04:45:24 INFO - Running setup.py install for mozdevice 04:45:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:24 INFO - Running setup.py install for mozfile 04:45:24 INFO - Running setup.py install for mozhttpd 04:45:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozinfo 04:45:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozInstall 04:45:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozleak 04:45:25 INFO - Running setup.py install for mozlog 04:45:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for moznetwork 04:45:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozprocess 04:45:25 INFO - Running setup.py install for mozprofile 04:45:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozrunner 04:45:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:25 INFO - Running setup.py install for mozscreenshot 04:45:25 INFO - Running setup.py install for moztest 04:45:26 INFO - Running setup.py install for mozversion 04:45:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:26 INFO - Cleaning up... 04:45:26 INFO - Return code: 0 04:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:26 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')]} 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:26 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')]} 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:26 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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:26 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 04:45:26 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 04:45:26 INFO - Using env: {'DISPLAY': ':0', 04:45:26 INFO - 'HOME': '/home/cltbld', 04:45:26 INFO - 'LANG': 'en_US.UTF-8', 04:45:26 INFO - 'LANGUAGE': 'en_US:en', 04:45:26 INFO - 'LOGNAME': 'cltbld', 04:45:26 INFO - 'MAIL': '/var/mail/cltbld', 04:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:26 INFO - 'MOZ_NO_REMOTE': '1', 04:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:26 INFO - 'NO_EM_RESTART': '1', 04:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:26 INFO - 'PWD': '/builds/slave/test', 04:45:26 INFO - 'SHELL': '/bin/bash', 04:45:26 INFO - 'SHLVL': '1', 04:45:26 INFO - 'TERM': 'linux', 04:45:26 INFO - 'TMOUT': '86400', 04:45:26 INFO - 'USER': 'cltbld', 04:45:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:26 INFO - '_': '/tools/buildbot/bin/python'} 04:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:26 INFO - Running setup.py (path:/tmp/pip-NL6Rus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:26 INFO - Running setup.py (path:/tmp/pip-MPlBAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:26 INFO - Running setup.py (path:/tmp/pip-NJ4Xrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:26 INFO - Running setup.py (path:/tmp/pip-KL6gDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:26 INFO - Running setup.py (path:/tmp/pip-F4vN35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:26 INFO - Running setup.py (path:/tmp/pip-THTCW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:26 INFO - Running setup.py (path:/tmp/pip-1tQhWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:26 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)) 04:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:26 INFO - Running setup.py (path:/tmp/pip-YPfj4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:27 INFO - Running setup.py (path:/tmp/pip-rLddyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:27 INFO - Running setup.py (path:/tmp/pip-PMWr7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:27 INFO - Running setup.py (path:/tmp/pip-qpf7ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:27 INFO - Running setup.py (path:/tmp/pip-HmMBpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:27 INFO - Running setup.py (path:/tmp/pip-yJBZIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:27 INFO - Running setup.py (path:/tmp/pip-3z53dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:27 INFO - Running setup.py (path:/tmp/pip-5WmYlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:27 INFO - Running setup.py (path:/tmp/pip-7R44Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:27 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)) 04:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:27 INFO - Running setup.py (path:/tmp/pip-JCwbDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:27 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)) 04:45:27 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)) 04:45:27 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)) 04:45:27 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)) 04:45:27 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)) 04:45:27 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)) 04:45:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:27 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 04:45:27 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 04:45:27 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 04:45:27 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 04:45:27 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 04:45:27 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 04:45:29 INFO - Downloading blessings-1.6.tar.gz 04:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:29 INFO - Installing collected packages: blessings 04:45:29 INFO - Running setup.py install for blessings 04:45:29 INFO - Successfully installed blessings 04:45:29 INFO - Cleaning up... 04:45:29 INFO - Return code: 0 04:45:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:30 INFO - Reading from file tmpfile_stdout 04:45:30 INFO - Current package versions: 04:45:30 INFO - argparse == 1.2.1 04:45:30 INFO - blessings == 1.6 04:45:30 INFO - blobuploader == 1.2.4 04:45:30 INFO - docopt == 0.6.1 04:45:30 INFO - manifestparser == 1.1 04:45:30 INFO - mozInstall == 1.12 04:45:30 INFO - mozcrash == 0.17 04:45:30 INFO - mozdebug == 0.1 04:45:30 INFO - mozdevice == 0.48 04:45:30 INFO - mozfile == 1.2 04:45:30 INFO - mozhttpd == 0.7 04:45:30 INFO - mozinfo == 0.9 04:45:30 INFO - mozleak == 0.1 04:45:30 INFO - mozlog == 3.1 04:45:30 INFO - moznetwork == 0.27 04:45:30 INFO - mozprocess == 0.22 04:45:30 INFO - mozprofile == 0.28 04:45:30 INFO - mozrunner == 6.11 04:45:30 INFO - mozscreenshot == 0.1 04:45:30 INFO - mozsystemmonitor == 0.0 04:45:30 INFO - moztest == 0.7 04:45:30 INFO - mozversion == 1.4 04:45:30 INFO - psutil == 3.1.1 04:45:30 INFO - requests == 1.2.3 04:45:30 INFO - wsgiref == 0.1.2 04:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:30 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 04:45:30 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 04:45:30 INFO - Using env: {'DISPLAY': ':0', 04:45:30 INFO - 'HOME': '/home/cltbld', 04:45:30 INFO - 'LANG': 'en_US.UTF-8', 04:45:30 INFO - 'LANGUAGE': 'en_US:en', 04:45:30 INFO - 'LOGNAME': 'cltbld', 04:45:30 INFO - 'MAIL': '/var/mail/cltbld', 04:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:30 INFO - 'MOZ_NO_REMOTE': '1', 04:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:30 INFO - 'NO_EM_RESTART': '1', 04:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:30 INFO - 'PWD': '/builds/slave/test', 04:45:30 INFO - 'SHELL': '/bin/bash', 04:45:30 INFO - 'SHLVL': '1', 04:45:30 INFO - 'TERM': 'linux', 04:45:30 INFO - 'TMOUT': '86400', 04:45:30 INFO - 'USER': 'cltbld', 04:45:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:30 INFO - '_': '/tools/buildbot/bin/python'} 04:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 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)) 04:45:30 INFO - Cleaning up... 04:45:30 INFO - Return code: 0 04:45:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:45:30 INFO - Using env: {'DISPLAY': ':0', 04:45:30 INFO - 'HOME': '/home/cltbld', 04:45:30 INFO - 'LANG': 'en_US.UTF-8', 04:45:30 INFO - 'LANGUAGE': 'en_US:en', 04:45:30 INFO - 'LOGNAME': 'cltbld', 04:45:30 INFO - 'MAIL': '/var/mail/cltbld', 04:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:30 INFO - 'MOZ_NO_REMOTE': '1', 04:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:30 INFO - 'NO_EM_RESTART': '1', 04:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:30 INFO - 'PWD': '/builds/slave/test', 04:45:30 INFO - 'SHELL': '/bin/bash', 04:45:30 INFO - 'SHLVL': '1', 04:45:30 INFO - 'TERM': 'linux', 04:45:30 INFO - 'TMOUT': '86400', 04:45:30 INFO - 'USER': 'cltbld', 04:45:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:30 INFO - '_': '/tools/buildbot/bin/python'} 04:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:30 INFO - Downloading/unpacking jsonschema 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:32 INFO - warning: no files found matching '*.txt' 04:45:32 INFO - no previously-included directories found matching 'build' 04:45:32 INFO - no previously-included directories found matching 'dist' 04:45:32 INFO - no previously-included directories found matching '.git*' 04:45:32 INFO - Installing collected packages: jsonschema, functools32 04:45:32 INFO - Running setup.py install for functools32 04:45:32 INFO - warning: no files found matching '*.txt' 04:45:32 INFO - no previously-included directories found matching 'build' 04:45:32 INFO - no previously-included directories found matching 'dist' 04:45:32 INFO - no previously-included directories found matching '.git*' 04:45:32 INFO - Successfully installed jsonschema functools32 04:45:32 INFO - Cleaning up... 04:45:32 INFO - Return code: 0 04:45:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:32 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 0x7f19c0e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', '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 04:45:32 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 04:45:32 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 04:45:32 INFO - Using env: {'DISPLAY': ':0', 04:45:32 INFO - 'HOME': '/home/cltbld', 04:45:32 INFO - 'LANG': 'en_US.UTF-8', 04:45:32 INFO - 'LANGUAGE': 'en_US:en', 04:45:32 INFO - 'LOGNAME': 'cltbld', 04:45:32 INFO - 'MAIL': '/var/mail/cltbld', 04:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:32 INFO - 'MOZ_NO_REMOTE': '1', 04:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:32 INFO - 'NO_EM_RESTART': '1', 04:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:32 INFO - 'PWD': '/builds/slave/test', 04:45:32 INFO - 'SHELL': '/bin/bash', 04:45:32 INFO - 'SHLVL': '1', 04:45:32 INFO - 'TERM': 'linux', 04:45:32 INFO - 'TMOUT': '86400', 04:45:32 INFO - 'USER': 'cltbld', 04:45:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:32 INFO - '_': '/tools/buildbot/bin/python'} 04:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:33 INFO - Downloading/unpacking flake8 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:33 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 04:45:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45:34 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 04:45:34 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 04:45:34 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 04:45:34 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 04:45:34 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 04:45:34 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 04:45:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 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 04:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:35 INFO - no previously-included directories found matching 'docs/_build' 04:45:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:35 INFO - Running setup.py install for pep8 04:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:35 INFO - no previously-included directories found matching 'docs/_build' 04:45:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:45:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:35 INFO - Cleaning up... 04:45:36 INFO - Return code: 0 04:45:36 INFO - Running post-action listener: _resource_record_post_action 04:45:36 INFO - Running post-action listener: _start_resource_monitoring 04:45:36 INFO - Starting resource monitoring. 04:45:36 INFO - ##### 04:45:36 INFO - ##### Running install step. 04:45:36 INFO - ##### 04:45:36 INFO - Running pre-action listener: _resource_record_pre_action 04:45:36 INFO - Running main action method: install 04:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:36 INFO - Reading from file tmpfile_stdout 04:45:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:36 INFO - Reading from file tmpfile_stdout 04:45:36 INFO - Output received: 04:45:36 INFO - Usage: mozinstall [options] installer 04:45:36 INFO - Options: 04:45:36 INFO - -h, --help show this help message and exit 04:45:36 INFO - -d DEST, --destination=DEST 04:45:36 INFO - Directory to install application into. [default: 04:45:36 INFO - "/builds/slave/test"] 04:45:36 INFO - --app=APP Application being installed. [default: firefox] 04:45:36 INFO - mkdir: /builds/slave/test/build/application 04:45:36 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'] 04:45:36 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 04:45:52 INFO - Reading from file tmpfile_stdout 04:45:52 INFO - Output received: 04:45:52 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:52 INFO - Running post-action listener: _resource_record_post_action 04:45:52 INFO - ##### 04:45:52 INFO - ##### Running run-tests step. 04:45:52 INFO - ##### 04:45:52 INFO - Running pre-action listener: _resource_record_pre_action 04:45:52 INFO - Running main action method: run_tests 04:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:52 INFO - Python 2.7.3 04:45:52 INFO - Return code: 0 04:45:52 INFO - grabbing minidump binary from tooltool 04:45:52 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')]} 04:45:52 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 0x228b410>, '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 0x228c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:52 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 04:45:52 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 04:45:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:52 INFO - Return code: 0 04:45:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:45:53 INFO - Return code: 0 04:45:53 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/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:45:53 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/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 04:45:53 INFO - Using env: {'DISPLAY': ':0', 04:45:53 INFO - 'HOME': '/home/cltbld', 04:45:53 INFO - 'LANG': 'en_US.UTF-8', 04:45:53 INFO - 'LANGUAGE': 'en_US:en', 04:45:53 INFO - 'LOGNAME': 'cltbld', 04:45:53 INFO - 'MAIL': '/var/mail/cltbld', 04:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:53 INFO - 'MOZ_NO_REMOTE': '1', 04:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:53 INFO - 'NO_EM_RESTART': '1', 04:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:53 INFO - 'PWD': '/builds/slave/test', 04:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:53 INFO - 'SHELL': '/bin/bash', 04:45:53 INFO - 'SHLVL': '1', 04:45:53 INFO - 'TERM': 'linux', 04:45:53 INFO - 'TMOUT': '86400', 04:45:53 INFO - 'USER': 'cltbld', 04:45:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824', 04:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:53 INFO - '_': '/tools/buildbot/bin/python'} 04:45:53 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/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 04:45:53 INFO - mozversion application_buildid: 20160519020753 04:45:53 INFO - mozversion application_changeset: ca41d290daa081865b50f2434aabe15c9fd7ae66 04:45:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:53 INFO - mozversion application_name: Firefox 04:45:53 INFO - mozversion application_remotingname: firefox-dev 04:45:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:53 INFO - mozversion application_vendor: Mozilla 04:45:53 INFO - mozversion application_version: 48.0a2 04:45:53 INFO - mozversion platform_buildid: 20160519020753 04:45:53 INFO - mozversion platform_changeset: ca41d290daa081865b50f2434aabe15c9fd7ae66 04:45:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:53 INFO - mozversion platform_version: 48.0a2 04:45:53 INFO - using testdate: 1463658353 04:45:53 INFO - actual date: 1463658353 04:45:53 INFO - starting webserver on 'localhost:58267' 04:45:53 INFO - SUITE-START | Running 2 tests 04:45:53 INFO - TEST-START | dromaeo_css 04:45:53 INFO - operating with platform_type : linux_ 04:45:53 INFO - Initialising browser for dromaeo_css test... 04:45:53 INFO - TEST-INFO | started process 22864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsT4kN/profile http://localhost:58267/getInfo.html) 04:45:56 INFO - PROCESS | 22864 | 04:45:56 INFO - PROCESS | 22864 | (process:22941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:45:57 INFO - PROCESS | 22864 | __metrics Screen width/height:1600/1200 04:45:57 INFO - PROCESS | 22864 | colorDepth:24 04:45:57 INFO - PROCESS | 22864 | Browser inner width/height: 1024/697 04:45:57 INFO - PROCESS | 22864 | __metrics 04:45:57 ERROR - PROCESS | 22864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:45:58 INFO - TEST-INFO | 22864: exit 0 04:45:58 INFO - Browser initialized. 04:45:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:58 INFO - TEST-INFO | started process 22992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsT4kN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:00 INFO - PROCESS | 22992 | 04:46:00 INFO - PROCESS | 22992 | (process:23059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:46:10 INFO - PROCESS | 22992 | RSS: Main: 151977984 04:46:10 INFO - PROCESS | 22992 | 04:46:59 INFO - PROCESS | 22992 | 1463658419901 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] 04:49:07 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58267/tests/dromaeo/cssquery-ext.html) 04:49:08 INFO - PROCESS | 22992 | RSS: Main: 155709440 04:49:08 INFO - PROCESS | 22992 | 04:52:10 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-ext.html (next: http://localhost:58267/tests/dromaeo/cssquery-jquery.html) 04:52:11 INFO - PROCESS | 22992 | RSS: Main: 153169920 04:52:11 INFO - PROCESS | 22992 | 04:55:12 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58267/tests/dromaeo/cssquery-mootools.html) 04:55:13 INFO - PROCESS | 22992 | RSS: Main: 153063424 04:55:13 INFO - PROCESS | 22992 | 04:58:14 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58267/tests/dromaeo/cssquery-prototype.html) 04:58:15 INFO - PROCESS | 22992 | RSS: Main: 152727552 04:58:15 INFO - PROCESS | 22992 | 05:01:17 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58267/tests/dromaeo/cssquery-yui.html) 05:01:18 INFO - PROCESS | 22992 | RSS: Main: 153993216 05:01:18 INFO - PROCESS | 22992 | 05:04:20 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:58267/tests/dromaeo/cssquery-yui.html (next: http://localhost:58267/tests/dromaeo/cssquery-dojo.html) 05:04:21 INFO - PROCESS | 22992 | RSS: Main: 156053504 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | __start_tp_report 05:04:21 INFO - PROCESS | 22992 | _x_x_mozilla_page_load 05:04:21 INFO - PROCESS | 22992 | _x_x_mozilla_page_load_details 05:04:21 INFO - PROCESS | 22992 | |i|pagename|runs| 05:04:21 INFO - PROCESS | 22992 | |0;dojo.html;3353.8323083845808;3403.9149021274466;3421.7262618990485;3468.809215493147;3475.704565111965;5622.887542249157;5679.914801277974;5690.089585666295;5699.914501282474;5713.828585142447;5680.602357834953;5740.569457290699;5750.683712395817;5754.079347304421;5776.39347868473;5177.896442071156;5204.843854684346;5234.37187537496;5269.314989051437;5282.392524859632;5042.899142017158;5370.973145134269;5372.677639341632;5382.461753824606;5384.6499977501335;5056.393232812067;5155.510226528474;5161.122609156452;5178.404483484391;5198.090334191501;5181.222816577506;5213.504717051893;5219.086659834514;5223.660462069991;5224.895502089937;5188.377394712621;5206.661566998133;5259.0796610593;5296.020236256305;5310.787568497255;5270.841874743725;5382.138857782736;5446.319210098738;5508.9724551377385;5610;6003.8198854034445;6023.096535519663;6024.668643224621;6026.638401695912;6027.60820546663;6068.817935461943;6082.787102451437;6089.573729838913;6094.756209751605;6100.115483254947;5548.223248745179;5592.972035139839;5636.71816409182;5730.140478928152;5807.883842323172;6086.482648974798;6091.2081429414775;6124.418180272867;6130.233720784902;6135.294441139237;5861.853453663607;5878.147668588031;5900.055991041413;5901.055831067095;5950.315713692894;6023.728932198062;6052.54605904559;6052.969735151296;6058.636481811017;6086.513078953673;6012.819615411545;6017.338092809788;6019.939800601938;6028.2766068072115;6038.245219347582;5725.370209276976;5923.229980102646;5993.700314984233;6007.759689612367;6051.425114614105;4650.279206722963;4657.208274593328;4659.324397962277;4668.906621867543;4683.7423941682855;4143;4145.54399016108;4156.542780294165;4167.374893765959;4192.392103145027;5873.442023007808;5876.942150412967;5920.111983202554;5984.461398474158;5993.370696076936;5926.555508336892;6124.969375153096;6137.693115344215;6155.384461553898;6178.7219575119225;5842.357340692521;5845.766169353178;5846;5850.970745146332;5883.529317654577;4911.4106307243355;4997.650164488524;5070.163423035158;5074.13739664258;5112.182050871843;6382.329855365213;6395.16862807832;6421.646809425526;6423;6427.421532062137;5914.7338369774325;6190.628562286277;6213.471854892204;6219.813405597839;6227.1282020517165;6282.780102696383;6344.68276586178;6394;6397.648129352744;6406.615603063645;5883.646981181143;5909.320428150646;5917.556183286357;5934;5950.732217050157;5886.911696324473;6016;6025.367336429612;6031.155638210742;6129.328227221949;6003.609765365237;6007.789727359522;6008.489278411384;6025.548083893813;6049.909251361145;5954.583179177416;6008.1588577598295;6011.098335249748;6016.8796624068145;6024.246969128859;5651.350094738993;5791.797287094932;5826.854328641818;5869.8239052828485;5896.764129434775;5956.880862382642;5966.071953778866;6022.247219097613;6030.668313242813;6038.969805150946;5862.091375836752;5871.588988770745;5879.118132280192;5879.2944846618675;5883.61756485827 05:04:21 INFO - PROCESS | 22992 | |1;ext.html;607.5230943709187;665.3978149774455;675.3685304240533;681.454836131095;691.0084029417783;33253.16867078321;41150.58849411509;41351;41407.58592414075;41705.3744193837;44545;45426.7728661357;45473.77263113688;45495.77252113743;45514.544854551445;8764.298856091513;8960.372773905796;8962;8986.910130898672;8997.280217582611;8814.955925220396;8890.511021893793;8892.510911899843;8899.73300800977;8906.73279801607;9115.772105697344;9146.588403521857;9171.037041110687;9201.263898888074;9204;9098.272138228926;9105.089491050841;9126.680566180152;9127.132922372364;9144.954275228647;9036.412633178888;9117.361784675075;9172.495512746797;9180.8622870657;9201.493917834516;44904.3264351035;45454.31818522692;45503;45534;45577.316340254925;3890.649841514249;3956.3274243378696;4320.24395730749;4356.390105385217;4688.484266730657;33855;33991.320173596636;34135.82932085349;34386;35812.46281305783;4315.697901146921;4321.6326612238;4340.65274778017;4346.456692913386;4412.75729834859;314507;315314;315647;315679;315818;56310;63384.36615633785;63648;64031.6798416005;64079.679601601696;59222.40777592169;59360.10959835606;59367.40632593619;59639.40360596425;59673.70163149243;18051.187696553687;18120.27518899229;18322.908385457988;18333.44999649986;18362.81637183611;14383.137011779118;14397;14412.42350305997;14498.347574359179;14521.85478145205;17756.28974840992;17916.92498450071;18491.81508184901;18606.81393186051;18680;6853.862922741617;6943.132108486439;7040.3663670269925;7047.036848361319;7047.68285427157;1109.450821843193;1134.659602119361;1156.1271240213753;1169.8245263210586;1231.3736047340496;33706.32587348239;33990.49014264788;34204.14489637729;34322.48516272258;34354;1259.8803113704184;1283.6919139406662;1301.9283939383236;1311.6293473320402;1364.8089267502558;17829.375971840924;17856;17900.63078888537;17943.910280448774;17945.641087178185;500037;571656;572688;583987;589492;55624.44375556193;56247.15629265564;56417;56418.7179064102;56745;828.5194587139445;1387.3063468265866;1563.64817915968;1573.0718875863524;1582.3512359932602;31570.368592628478;32746.672533274363;33165;33188.50217246695;33266.334673305915;54038.64903377447;54488.182677260666;54662.72668636632;54742.45257547533;54853.72573137269;364516;365054;365848;368248;368362;29948.101556953327;30582.541261881535;30788.53817192789;30796.384072318877;31035.379292413574;49423.75288123536;49892.25161622506;49999.25001125059;51202.23196652128;51210;41534;42833.35749963815;42903.785481073646;44034;44637.330440044076;41759.16481670289;42453.36319955265;43331.566684332756;43920.34119488274;43982.56017439785;44102;45046;45074;45505.31742023806;45944.31083533683;37091.6290837099;37301;37343;37773.24453510859;38314.42528362133;29792.553111703775;29889.252768680955;29993.250168745955;30093.69906300909;30129.246768830955 05:04:21 INFO - PROCESS | 22992 | |2;jquery.html;421.63107281129004;436.51546783070785;437.6717461903572;438.52639149718306;449.1421385154356;18430.354937577187;18684.90657546714;19193.520161995955;21135.894320528416;21223.893880530613;20257.088431020602;20638.89680551599;20646;20761.688574671356;20850.374488765323;5720.79977200798;5785.16115163301;5836.649801011953;5871.677057761822;5913.704314784265;5853.5902486825935;5900.52795776339;5903;5908.379620139866;5921.082232254007;5467.781288748445;5721.971390143043;5722.570807189478;5722.685252311121;5865.736041878125;5702.885942281152;5712.057510510782;5718.628289161191;6179.69101544921;6642.800715978528;5959.553033522503;5982.192404025444;6004.6997650117755;6008.3390827009;6020.4280593343565;14432.711345773027;14453.132812031312;14781.482648107372;14823.110613363233;14891.702165956729;2456.1771806444863;2504.3113143885394;2550.7321731218326;2745.8330209661012;2848.473032488996;10523.368597884151;10642.255042147053;10679.893201067967;10845.783084338269;10846.783064338748;2059.8764074155447;2090.1221486975505;2104.736907886514;2121.554473560554;2159.84881058326;83489;86515.56742216312;87843;87993.56003220007;88223;11683.591074312528;11909.821352679717;11959.282443053444;11963.40182990847;11992.280463172237;16961.830381696273;17045.48863534096;17096;17164.570885727957;17181.7422738659;8998.14517620825;9104.180623743894;9201.079892010745;9285.814283714422;9289.581968811419;8750.781230469289;8902.554872256362;8924.241439477588;8996.325275604357;9007.81984360309;5048.217526283432;5154.8969020620125;5166.199239117943;5171.5862730981435;5230.607704422184;2055.393658870637;2062.3400511836066;2122.7771084036262;2130.2970019893396;2174.608570457301;984.2765567308023;1010.4846528270488;1054;1118.3290025984506;1174.0783484964263;17988.460346189637;18168.909155454403;18638.16128274231;18638.16128274231;18846.71729924052;1060.0936199549274;1070.29895418501;1090.5342621963048;1092.2900114925362;1154.6766905266538;10605.734856628646;10778.838317425245;10832.404217768099;10842.728931776768;11026.779464410827;567553;576844;584904;585577;594057;81616.59191704003;88665.55667221623;90225;97039.51480242553;99394.50302748584;1130.5929865248504;1177.1171621284036;1179.8820117988305;1190.541641468041;1191.53530123252;17254.223559939583;17411.82588174102;17430.564235894206;17577.209025594133;17595.824041759417;41066.79466602648;41650.58349416467;42003;42465.787671061444;42651;59766.40233597608;62924.68537657466;63277.68361158165;64054.3594564067;64079.718405630694;9384.718458446258;9474.621015159591;9515.429074255568;9558.330916835755;9612.807743844944;12063.75872482563;13240.27178505153;13272.80090798658;14279.071860329046;14326.212058336892;9416.446286362674;11879.762404751684;12496.312702801433;12533.248005119722;12617;11910.166288359731;12017.02652438126;12117.939410302892;12291.938540307241;12506.437210325375;12499.875001249871;12524.874751252371;12692.746145077232;12731.04517161198;12840.678983025498;8920.598573064357;8971.685990990283;9086.36395452312;9173.862392064259;9509.286803489904;12284.508619655113;12478.376081195722;12532;12547;12628.43172057278 05:04:21 INFO - PROCESS | 22992 | |3;mootools.html;1163.749793794334;1173.9295642261466;1255.9246445213284;1930.9572830671439;1961.9019049047554;8444.366672499564;8547.572621368938;8629.69796057139;8649.264812490937;8754.6935857245;8869.733907982754;8954.776130596738;8984.146506081928;8992;8996.865047024283;2461.7292097869263;2463.864487453189;2482.429041320497;2487.502499500098;2498.525280196766;2473.307473907309;2534.087728417768;2539.1366935242013;2539.860307683077;2542.8092893033004;2413.8431001984904;2422.1401402502124;2519.987400062997;2523.1925783749207;2525.02786427225;2486.589712697412;2508.8745562721883;2523.7602427769334;2525.722170561237;2531.974680253192;2449.6080627099755;2471.851688898672;2502.5245203411478;2513.4847356291916;2534.1763926723706;8867.955660221722;8890.377673562853;8925.107489251088;8942.821143577157;8947.686830960885;5390.757415916293;5461.399246082928;5496.890062198733;5499.917501237484;5528.668279903219;3628.455731640249;3666.32173047987;3707.7589956653;3743.232637309345;3751.606081361445;1235.8455193100863;1237.591724165394;1247.5945317771761;1274.8151518029833;1312.9934350328283;12371.876281237162;12421.75156496865;12428.378581071001;12472.937635311766;12480.063995200397;4662;4744.810207591727;4796.544328288807;4797.2564252540915;4816.470188279286;10022.398656080659;10024.699259022242;10049.447280399501;10053.949730251303;10060.0945914868;5402.081646120169;5437.592180586393;5451.127819548853;5465.180222966507;5465.180222966507;4308.353746937984;5012.8496145115705;5092.541671249605;5106.361704786902;5112.514311140436;4125.628693417607;4154.729942553724;4165.604267594574;4169.687273454503;4171.560811520021;1265.4179077624397;1275.4005617359826;1280.4622058735354;1297.8377702787152;1298.9415476303589;966.7486453521994;1067.0876400677464;1069.085931528532;1089.128697042363;1094.6442406218011;6014.428629280212;6077.9392206078255;6155.96922015396;6297.370262973757;6374.776882809172;508.1716801613347;508.63632502760703;508.8397154896196;510.04112268934165;516.1174391790006;4066.4713587234064;4213.936790948138;4236.76697781625;4240.067185219247;4251.511076226212;10672.573097076185;10968.561257549609;11118.166137539716;11153.888461115448;11163.051140653135;10248.538815753309;10526.526306316235;10978.286411383235;10992.835107473395;11001.22991390611;8370.288525475402;8393.916060839436;8406;8434.873476897852;8458.87311690325;6104.236970378703;6248.4688801452385;6281.685915704288;6358.77744278948;6359.55483116196;9562.18721408688;9741.220702343937;9791.559379828068;9794.16749576294;9849.064338888082;10026.398416094766;10046.346987445793;10088.848667270144;10207.642732504326;10267.640632577824;7098.858022839618;7972.760817175494;8066.193380661887;8153.103158652425;8367.205115514016;8027;8057;8274.544900030556;8303.294219991369;8415.368847336353;7414.740484083031;7595.658195381332;7617.7333793319185;7815;7829.138794732461;7684.193159718149;7722.613869306625;7786.182450842806;7863.52818830872;7896.763097107096;7064.081669382947;7081.150261968597;7089.7873063808165;7099.254578269208;7109.466789990668;5199.11615025439;5374.946250537445;5443.346798384061;5474.644148130359;5525.198846167203;5243.764030618555;5389.487998640123;5490.862728431821;5510.972445137909;5548.639338442988 05:04:21 INFO - PROCESS | 22992 | |4;prototype.html;369.5214696967427;371.2815701617371;371.86984555405604;374.5243540703305;382.8774792066536;6499.512536559753;6525.771597994071;6592.802215933523;6593.439557637601;6679.098321726566;6522.249941256757;6599.604023758578;6624.304448032959;6647.966760166192;6681.23165835929;5160.819371322004;5162.483751624845;5166;5174.767135478913;5180.11937970544;5096.337476128098;5111.667741596784;5165.38015438148;5166.741662916858;5185.637005409623;5119.308893299412;5124.948750512484;5127.051495473331;5133.307003554528;5141.383034035921;5020.849374518771;5111.642185047048;5124.795008199668;5141.742912854361;5145.125328694131;4475.060237350161;4516.706414083107;4517.096580683843;4532.252178390595;4540.568645978627;6423.518236132309;6436.002419624966;6436.903446448307;6439.162908821823;6442.484601231937;5740.08158694611;5974.6713930733795;5975.402459754033;5976.073708575178;6008.309044459899;7032.964835175842;7064.611446370448;7076.186238582526;7077.07997960267;7089.042979197794;5002.324686167357;5003.149464591028;5003.349564556621;5012.223105418666;5017.7491125443585;7339.412846972229;7340.522866013692;7353.889691654629;7409.444291678145;7420.406367490587;5043.823466178666;5120.769565369567;5160.122779127557;5178.171492561172;5184.870378240575;5174.896502069938;5204.297419848348;5230.37235531731;5238.345206849144;5246.055709972242;5951.315598706117;5954.225950626391;5971.552133589998;5973.253343332083;5975.67133807636;7025.929740702528;7117.25268846774;7123.358897699232;7162.355388015104;7171.569705817667;1837.990810045968;1861.9813801862078;1863.5620629152138;1864.0679660169915;1864.3661155207294;1195.557643671847;1208.8247204155348;1218.232513516479;1245.2839617220134;1258.2010423381219;6796.898046529306;6827.873400888897;6853.828654283583;6854;6855.520113592101;7296.343329100407;7299.671514781848;7304.342609165201;7307.926920730831;7337.74317898871;6781.220159681699;6790.0493930849725;6811.659417029129;6840.555363901331;6842.692078856463;3866.3233934061427;3918.8628398005935;3942.8619998299923;3943.2704949584418;3979.9403008954887;7556.773296801105;7560.659770310349;7562.697492100365;7565.092188937363;7566.924330756622;7338.743143989935;7356.337929586363;7364.96317518409;7381.261873812576;7396.815079623052;7503;7521.661525231269;7531.736389226351;7558.206388329256;7565.659545320474;7016.508844381048;7197.784066478014;7209.279072092959;7263.382612477999;7290.599017053901;7109.715611375694;7139.571625702474;7151.642417879189;7164.283571642794;7165.3551180394015;7482.588457634664;7504.099508058849;7561.3194812467145;7563.243675632392;7568.3945284378215;5126.948730512796;5127.846164615067;5131.4868513148385;5136.486351364833;5137.152369858932;7105.111861017373;7205.531640443354;7233.782986510413;7254.673539690621;7262.273772622695;7013.544119632412;7019.719211231493;7024.121984751906;7034.226235114235;7043.837766768426;6915.204751453446;6952.270011648704;6966.512344136065;6994.650267486503;7010.579365238102;6793.082933803873;6855.211650660238;6859.108315918898;6869.003994420881;6875.449964002968;6882.8623427530165;7049.471289653194;7051.823704407431;7071.7878463646175;7076.964615176891;6738.629375384205;6830.043793868763;6945.270746571739;7040.753573624898;7056.682449289691 05:04:21 INFO - PROCESS | 22992 | |5;yui.html;854.2610641794847;892.6384814150272;914.6750222213391;929.4748467116079;936.9297302702295;15075.321610527526;15271.770923436157;15305.770413443794;15328.540143795675;15330.923345383286;14177.291135443213;14184.290785460737;14310.71378572428;14319.498817541387;14423.63940901478;756.3722110648149;896.9820603587924;906.8413027720155;916.2715641065369;921.7280902133853;914.8856392950881;916.8808054952847;916.9128932751378;919.2140719684674;922.1654402765474;947.7346343023964;952.119289657068;953.3326671330062;954.1889394015101;956.2541217850088;942.4627962061628;944.3483996042709;946.6923249943795;946.9147776700061;948.5541795356206;697.5291678117301;702.8840241360169;703.5602748282323;705.1679018757864;706.9081019467487;14237.715245695028;14237.715245695132;14243.786343204756;14266.144031358048;14276.500322488662;14954.40182392703;14966.925165374212;15256.923715381352;15315.387384504607;15412.229388530528;11808.52765889372;11979.580714675032;12066;12242.204256723284;12388.938055309756;4049.6152865477734;4065.89835254121;4101.753894766323;4227.661787057059;4247.086876321575;55571.166432503545;56342.43657563413;57702;59479.702601486715;59623.70188149075;11850.88149118515;11914.344711040976;12014.579489717818;12022.27866328023;12081;21962.670559941613;22067.66898496524;22074.889625552092;22107.557848842935;22192.88903555472;8912.287017038621;8943.105689431135;8946.86579701305;9079.18287354128;9110.453372797654;5233.188855727369;5246.63273570854;5248.317718696621;5249.606279529051;5340.946590534045;3701.9819549624067;3775.811209439517;3777.9244415111543;3779.848806047782;3799.2781371539318;706.9469789765789;713.400743375567;718.5401343140394;720.4344589497219;736.7716008037526;630.2909227119491;740.1266505523533;743.7805847275067;748.221849276757;827.5117680568494;9648.228141748643;9849.45827979468;9966.40201587907;10040.69877903664;10134.138598219233;764.537454839825;775.5734346109617;796.2634563029291;798.964046617892;820.216693058128;4446.911061778746;4611.492735799059;4615.815367385334;4679.532046795293;4714.198586240347;62206.68896655488;63278;63446.68276658587;63759.04361434582;63883.6805815968;56964.71517642385;57163.428365716645;57557.42442575604;58872.41127588755;60076.39923600708;51611;52829.47170528323;53466.46533534615;54644;54667.45332546624;8922.86615700778;9055.637774488947;9182.317018320839;9339.392939458914;9445.48049857237;38622;39760.403593945535;39999.600003999585;40593.797031014656;40738;44006.11987760163;44165.77917110394;44421.77789111163;47900.7604961973;48136;12855.228686278853;12950.546730864375;12978.740425191632;13222.669433264246;13307.334633268492;13682.794758078835;13948.930255348658;14150.78773818373;14449.783253251;14583.562493125222;13604.727905441638;13828.446862125806;13862.168269903837;14044.297785110908;14068;13536.526221582197;13687.863121368659;13836.446542138201;14157.858421415654;14211.50259740904;13360.599182024554;13889.583312500641;14130.010899237366;14467.638309042359;14477.276136192937;9846.803063938825;9948.403095814274;10052.296339256181;10141.695749127539;10489.160867130458;10923.235373523778;11732.74852343788;11995;12006.21959572625;12028.218165819193 05:04:21 INFO - PROCESS | 22992 | __end_tp_report 05:04:21 INFO - PROCESS | 22992 | __start_cc_report 05:04:21 INFO - PROCESS | 22992 | _x_x_mozilla_cycle_collect,333 05:04:21 INFO - PROCESS | 22992 | __end_cc_report 05:04:21 INFO - PROCESS | 22992 | __startTimestamp1463659461025__endTimestamp 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | ------- Summary: start ------- 05:04:21 INFO - PROCESS | 22992 | Number of tests: 6 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#0] dojo.html Cycles:165 Average:5653.63 Median:5883.53 stddev:627.29 (10.7%) stddev-sans-first:602.71 05:04:21 INFO - PROCESS | 22992 | Values: 3353.8 3403.9 3421.7 3468.8 3475.7 5622.9 5679.9 5690.1 5699.9 5713.8 5680.6 5740.6 5750.7 5754.1 5776.4 5177.9 5204.8 5234.4 5269.3 5282.4 5042.9 5371.0 5372.7 5382.5 5384.6 5056.4 5155.5 5161.1 5178.4 5198.1 5181.2 5213.5 5219.1 5223.7 5224.9 5188.4 5206.7 5259.1 5296.0 5310.8 5270.8 5382.1 5446.3 5509.0 5610.0 6003.8 6023.1 6024.7 6026.6 6027.6 6068.8 6082.8 6089.6 6094.8 6100.1 5548.2 5593.0 5636.7 5730.1 5807.9 6086.5 6091.2 6124.4 6130.2 6135.3 5861.9 5878.1 5900.1 5901.1 5950.3 6023.7 6052.5 6053.0 6058.6 6086.5 6012.8 6017.3 6019.9 6028.3 6038.2 5725.4 5923.2 5993.7 6007.8 6051.4 4650.3 4657.2 4659.3 4668.9 4683.7 4143.0 4145.5 4156.5 4167.4 4192.4 5873.4 5876.9 5920.1 5984.5 5993.4 5926.6 6125.0 6137.7 6155.4 6178.7 5842.4 5845.8 5846.0 5851.0 5883.5 4911.4 4997.7 5070.2 5074.1 5112.2 6382.3 6395.2 6421.6 6423.0 6427.4 5914.7 6190.6 6213.5 6219.8 6227.1 6282.8 6344.7 6394.0 6397.6 6406.6 5883.6 5909.3 5917.6 5934.0 5950.7 5886.9 6016.0 6025.4 6031.2 6129.3 6003.6 6007.8 6008.5 6025.5 6049.9 5954.6 6008.2 6011.1 6016.9 6024.2 5651.4 5791.8 5826.9 5869.8 5896.8 5956.9 5966.1 6022.2 6030.7 6039.0 5862.1 5871.6 5879.1 5879.3 5883.6 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#1] ext.html Cycles:180 Average:58997.09 Median:4343.55 stddev:113727.43 (2618.3%) stddev-sans-first:113961.96 05:04:21 INFO - PROCESS | 22992 | Values: 607.5 665.4 675.4 681.5 691.0 33253.2 41150.6 41351.0 41407.6 41705.4 44545.0 45426.8 45473.8 45495.8 45514.5 8764.3 8960.4 8962.0 8986.9 8997.3 8815.0 8890.5 8892.5 8899.7 8906.7 9115.8 9146.6 9171.0 9201.3 9204.0 9098.3 9105.1 9126.7 9127.1 9145.0 9036.4 9117.4 9172.5 9180.9 9201.5 44904.3 45454.3 45503.0 45534.0 45577.3 3890.6 3956.3 4320.2 4356.4 4688.5 33855.0 33991.3 34135.8 34386.0 35812.5 4315.7 4321.6 4340.7 4346.5 4412.8 314507.0 315314.0 315647.0 315679.0 315818.0 56310.0 63384.4 63648.0 64031.7 64079.7 59222.4 59360.1 59367.4 59639.4 59673.7 18051.2 18120.3 18322.9 18333.4 18362.8 14383.1 14397.0 14412.4 14498.3 14521.9 17756.3 17916.9 18491.8 18606.8 18680.0 6853.9 6943.1 7040.4 7047.0 7047.7 1109.5 1134.7 1156.1 1169.8 1231.4 33706.3 33990.5 34204.1 34322.5 34354.0 1259.9 1283.7 1301.9 1311.6 1364.8 17829.4 17856.0 17900.6 17943.9 17945.6 500037.0 571656.0 572688.0 583987.0 589492.0 55624.4 56247.2 56417.0 56418.7 56745.0 828.5 1387.3 1563.6 1573.1 1582.4 31570.4 32746.7 33165.0 33188.5 33266.3 54038.6 54488.2 54662.7 54742.5 54853.7 364516.0 365054.0 365848.0 368248.0 368362.0 29948.1 30582.5 30788.5 30796.4 31035.4 49423.8 49892.3 49999.3 51202.2 51210.0 41534.0 42833.4 42903.8 44034.0 44637.3 41759.2 42453.4 43331.6 43920.3 43982.6 44102.0 45046.0 45074.0 45505.3 45944.3 37091.6 37301.0 37343.0 37773.2 38314.4 29792.6 29889.3 29993.3 30093.7 30129.2 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#2] jquery.html Cycles:180 Average:31963.78 Median:2145.07 stddev:95587.55 (4456.1%) stddev-sans-first:95826.35 05:04:21 INFO - PROCESS | 22992 | Values: 421.6 436.5 437.7 438.5 449.1 18430.4 18684.9 19193.5 21135.9 21223.9 20257.1 20638.9 20646.0 20761.7 20850.4 5720.8 5785.2 5836.6 5871.7 5913.7 5853.6 5900.5 5903.0 5908.4 5921.1 5467.8 5722.0 5722.6 5722.7 5865.7 5702.9 5712.1 5718.6 6179.7 6642.8 5959.6 5982.2 6004.7 6008.3 6020.4 14432.7 14453.1 14781.5 14823.1 14891.7 2456.2 2504.3 2550.7 2745.8 2848.5 10523.4 10642.3 10679.9 10845.8 10846.8 2059.9 2090.1 2104.7 2121.6 2159.8 83489.0 86515.6 87843.0 87993.6 88223.0 11683.6 11909.8 11959.3 11963.4 11992.3 16961.8 17045.5 17096.0 17164.6 17181.7 8998.1 9104.2 9201.1 9285.8 9289.6 8750.8 8902.6 8924.2 8996.3 9007.8 5048.2 5154.9 5166.2 5171.6 5230.6 2055.4 2062.3 2122.8 2130.3 2174.6 984.3 1010.5 1054.0 1118.3 1174.1 17988.5 18168.9 18638.2 18638.2 18846.7 1060.1 1070.3 1090.5 1092.3 1154.7 10605.7 10778.8 10832.4 10842.7 11026.8 567553.0 576844.0 584904.0 585577.0 594057.0 81616.6 88665.6 90225.0 97039.5 99394.5 1130.6 1177.1 1179.9 1190.5 1191.5 17254.2 17411.8 17430.6 17577.2 17595.8 41066.8 41650.6 42003.0 42465.8 42651.0 59766.4 62924.7 63277.7 64054.4 64079.7 9384.7 9474.6 9515.4 9558.3 9612.8 12063.8 13240.3 13272.8 14279.1 14326.2 9416.4 11879.8 12496.3 12533.2 12617.0 11910.2 12017.0 12117.9 12291.9 12506.4 12499.9 12524.9 12692.7 12731.0 12840.7 8920.6 8971.7 9086.4 9173.9 9509.3 12284.5 12478.4 12532.0 12547.0 12628.4 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#3] mootools.html Cycles:180 Average:5882.19 Median:2760.51 stddev:3254.44 (117.9%) stddev-sans-first:3244.24 05:04:21 INFO - PROCESS | 22992 | Values: 1163.7 1173.9 1255.9 1931.0 1961.9 8444.4 8547.6 8629.7 8649.3 8754.7 8869.7 8954.8 8984.1 8992.0 8996.9 2461.7 2463.9 2482.4 2487.5 2498.5 2473.3 2534.1 2539.1 2539.9 2542.8 2413.8 2422.1 2520.0 2523.2 2525.0 2486.6 2508.9 2523.8 2525.7 2532.0 2449.6 2471.9 2502.5 2513.5 2534.2 8868.0 8890.4 8925.1 8942.8 8947.7 5390.8 5461.4 5496.9 5499.9 5528.7 3628.5 3666.3 3707.8 3743.2 3751.6 1235.8 1237.6 1247.6 1274.8 1313.0 12371.9 12421.8 12428.4 12472.9 12480.1 4662.0 4744.8 4796.5 4797.3 4816.5 10022.4 10024.7 10049.4 10053.9 10060.1 5402.1 5437.6 5451.1 5465.2 5465.2 4308.4 5012.8 5092.5 5106.4 5112.5 4125.6 4154.7 4165.6 4169.7 4171.6 1265.4 1275.4 1280.5 1297.8 1298.9 966.7 1067.1 1069.1 1089.1 1094.6 6014.4 6077.9 6156.0 6297.4 6374.8 508.2 508.6 508.8 510.0 516.1 4066.5 4213.9 4236.8 4240.1 4251.5 10672.6 10968.6 11118.2 11153.9 11163.1 10248.5 10526.5 10978.3 10992.8 11001.2 8370.3 8393.9 8406.0 8434.9 8458.9 6104.2 6248.5 6281.7 6358.8 6359.6 9562.2 9741.2 9791.6 9794.2 9849.1 10026.4 10046.3 10088.8 10207.6 10267.6 7098.9 7972.8 8066.2 8153.1 8367.2 8027.0 8057.0 8274.5 8303.3 8415.4 7414.7 7595.7 7617.7 7815.0 7829.1 7684.2 7722.6 7786.2 7863.5 7896.8 7064.1 7081.2 7089.8 7099.3 7109.5 5199.1 5374.9 5443.3 5474.6 5525.2 5243.8 5389.5 5490.9 5511.0 5548.6 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#4] prototype.html Cycles:180 Average:5926.45 Median:6759.92 stddev:1754.12 (25.9%) stddev-sans-first:1708.74 05:04:21 INFO - PROCESS | 22992 | Values: 369.5 371.3 371.9 374.5 382.9 6499.5 6525.8 6592.8 6593.4 6679.1 6522.2 6599.6 6624.3 6648.0 6681.2 5160.8 5162.5 5166.0 5174.8 5180.1 5096.3 5111.7 5165.4 5166.7 5185.6 5119.3 5124.9 5127.1 5133.3 5141.4 5020.8 5111.6 5124.8 5141.7 5145.1 4475.1 4516.7 4517.1 4532.3 4540.6 6423.5 6436.0 6436.9 6439.2 6442.5 5740.1 5974.7 5975.4 5976.1 6008.3 7033.0 7064.6 7076.2 7077.1 7089.0 5002.3 5003.1 5003.3 5012.2 5017.7 7339.4 7340.5 7353.9 7409.4 7420.4 5043.8 5120.8 5160.1 5178.2 5184.9 5174.9 5204.3 5230.4 5238.3 5246.1 5951.3 5954.2 5971.6 5973.3 5975.7 7025.9 7117.3 7123.4 7162.4 7171.6 1838.0 1862.0 1863.6 1864.1 1864.4 1195.6 1208.8 1218.2 1245.3 1258.2 6796.9 6827.9 6853.8 6854.0 6855.5 7296.3 7299.7 7304.3 7307.9 7337.7 6781.2 6790.0 6811.7 6840.6 6842.7 3866.3 3918.9 3942.9 3943.3 3979.9 7556.8 7560.7 7562.7 7565.1 7566.9 7338.7 7356.3 7365.0 7381.3 7396.8 7503.0 7521.7 7531.7 7558.2 7565.7 7016.5 7197.8 7209.3 7263.4 7290.6 7109.7 7139.6 7151.6 7164.3 7165.4 7482.6 7504.1 7561.3 7563.2 7568.4 5126.9 5127.8 5131.5 5136.5 5137.2 7105.1 7205.5 7233.8 7254.7 7262.3 7013.5 7019.7 7024.1 7034.2 7043.8 6915.2 6952.3 6966.5 6994.7 7010.6 6793.1 6855.2 6859.1 6869.0 6875.4 6882.9 7049.5 7051.8 7071.8 7077.0 6738.6 6830.0 6945.3 7040.8 7056.7 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - PROCESS | 22992 | [#5] yui.html Cycles:180 Average:15771.52 Median:4647.67 stddev:17933.17 (385.9%) stddev-sans-first:17948.48 05:04:21 INFO - PROCESS | 22992 | Values: 854.3 892.6 914.7 929.5 936.9 15075.3 15271.8 15305.8 15328.5 15330.9 14177.3 14184.3 14310.7 14319.5 14423.6 756.4 897.0 906.8 916.3 921.7 914.9 916.9 916.9 919.2 922.2 947.7 952.1 953.3 954.2 956.3 942.5 944.3 946.7 946.9 948.6 697.5 702.9 703.6 705.2 706.9 14237.7 14237.7 14243.8 14266.1 14276.5 14954.4 14966.9 15256.9 15315.4 15412.2 11808.5 11979.6 12066.0 12242.2 12388.9 4049.6 4065.9 4101.8 4227.7 4247.1 55571.2 56342.4 57702.0 59479.7 59623.7 11850.9 11914.3 12014.6 12022.3 12081.0 21962.7 22067.7 22074.9 22107.6 22192.9 8912.3 8943.1 8946.9 9079.2 9110.5 5233.2 5246.6 5248.3 5249.6 5340.9 3702.0 3775.8 3777.9 3779.8 3799.3 706.9 713.4 718.5 720.4 736.8 630.3 740.1 743.8 748.2 827.5 9648.2 9849.5 9966.4 10040.7 10134.1 764.5 775.6 796.3 799.0 820.2 4446.9 4611.5 4615.8 4679.5 4714.2 62206.7 63278.0 63446.7 63759.0 63883.7 56964.7 57163.4 57557.4 58872.4 60076.4 51611.0 52829.5 53466.5 54644.0 54667.5 8922.9 9055.6 9182.3 9339.4 9445.5 38622.0 39760.4 39999.6 40593.8 40738.0 44006.1 44165.8 44421.8 47900.8 48136.0 12855.2 12950.5 12978.7 13222.7 13307.3 13682.8 13948.9 14150.8 14449.8 14583.6 13604.7 13828.4 13862.2 14044.3 14068.0 13536.5 13687.9 13836.4 14157.9 14211.5 13360.6 13889.6 14130.0 14467.6 14477.3 9846.8 9948.4 10052.3 10141.7 10489.2 10923.2 11732.7 11995.0 12006.2 12028.2 05:04:21 INFO - PROCESS | 22992 | -------- Summary: end -------- 05:04:21 INFO - PROCESS | 22992 | 05:04:21 INFO - TEST-INFO | 22992: exit 0 05:04:21 INFO - TEST-OK | dromaeo_css | took 1108387ms 05:04:21 INFO - TEST-START | kraken 05:04:21 INFO - operating with platform_type : linux_ 05:04:21 INFO - Initialising browser for kraken test... 05:04:21 INFO - TEST-INFO | started process 23228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kbJwB/profile http://localhost:58267/getInfo.html) 05:04:24 INFO - PROCESS | 23228 | 05:04:24 INFO - PROCESS | 23228 | (process:23306): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:04:25 INFO - PROCESS | 23228 | __metrics Screen width/height:1600/1200 05:04:25 INFO - PROCESS | 23228 | colorDepth:24 05:04:25 INFO - PROCESS | 23228 | Browser inner width/height: 1024/697 05:04:25 INFO - PROCESS | 23228 | __metrics 05:04:25 ERROR - PROCESS | 23228 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:04:26 INFO - TEST-INFO | 23228: exit 0 05:04:26 INFO - Browser initialized. 05:04:26 INFO - Running cycle 1/1 for kraken test... 05:04:26 INFO - TEST-INFO | started process 23357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kbJwB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:28 INFO - PROCESS | 23357 | 05:04:28 INFO - PROCESS | 23357 | (process:23430): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:04:38 INFO - PROCESS | 23357 | RSS: Main: 151515136 05:04:38 INFO - PROCESS | 23357 | 05:04:40 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:41 INFO - PROCESS | 23357 | RSS: Main: 156491776 05:04:41 INFO - PROCESS | 23357 | 05:04:44 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-dft) 05:04:45 INFO - PROCESS | 23357 | RSS: Main: 156454912 05:04:45 INFO - PROCESS | 23357 | 05:04:47 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-fft) 05:04:48 INFO - PROCESS | 23357 | RSS: Main: 156438528 05:04:48 INFO - PROCESS | 23357 | 05:04:50 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58267/tests/kraken/driver.html?testName=audio-oscillator) 05:04:51 INFO - PROCESS | 23357 | RSS: Main: 157032448 05:04:51 INFO - PROCESS | 23357 | 05:04:53 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:54 INFO - PROCESS | 23357 | RSS: Main: 156778496 05:04:54 INFO - PROCESS | 23357 | 05:04:57 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:57 INFO - PROCESS | 23357 | RSS: Main: 157052928 05:04:57 INFO - PROCESS | 23357 | 05:05:01 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58267/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:01 INFO - PROCESS | 23357 | RSS: Main: 156663808 05:05:01 INFO - PROCESS | 23357 | 05:05:04 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58267/tests/kraken/driver.html?testName=json-parse-financial) 05:05:05 INFO - PROCESS | 23357 | RSS: Main: 157020160 05:05:05 INFO - PROCESS | 23357 | 05:05:06 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:07 INFO - PROCESS | 23357 | RSS: Main: 156815360 05:05:07 INFO - PROCESS | 23357 | 05:05:08 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:09 INFO - PROCESS | 23357 | RSS: Main: 156213248 05:05:09 INFO - PROCESS | 23357 | 05:05:11 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:12 INFO - PROCESS | 23357 | RSS: Main: 156409856 05:05:12 INFO - PROCESS | 23357 | 05:05:14 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:15 INFO - PROCESS | 23357 | RSS: Main: 157188096 05:05:15 INFO - PROCESS | 23357 | 05:05:18 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:18 INFO - PROCESS | 23357 | RSS: Main: 157216768 05:05:18 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | Cycle 1(1): loaded http://localhost:58267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58267/tests/kraken/driver.html?testName=ai-astar) 05:05:20 INFO - PROCESS | 23357 | RSS: Main: 158650368 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | __start_tp_report 05:05:20 INFO - PROCESS | 23357 | _x_x_mozilla_page_load 05:05:20 INFO - PROCESS | 23357 | _x_x_mozilla_page_load_details 05:05:20 INFO - PROCESS | 23357 | |i|pagename|runs| 05:05:20 INFO - PROCESS | 23357 | |0;ai-astar;109;111;105;111;113;115;101;111;112;112 05:05:20 INFO - PROCESS | 23357 | |1;audio-beat-detection;153;130;154;180;131;156;151;129;183;126 05:05:20 INFO - PROCESS | 23357 | |2;audio-dft;163;163;162;162;162;164;164;163;162;161 05:05:20 INFO - PROCESS | 23357 | |3;audio-fft;76;77;78;166;74;76;75;76;164;76 05:05:20 INFO - PROCESS | 23357 | |4;audio-oscillator;93;93;161;92;94;92;150;92;92;140 05:05:20 INFO - PROCESS | 23357 | |5;imaging-gaussian-blur;118;118;118;117;116;118;118;118;118;118 05:05:20 INFO - PROCESS | 23357 | |6;imaging-darkroom;146;146;147;147;146;146;147;147;147;146 05:05:20 INFO - PROCESS | 23357 | |7;imaging-desaturate;95;95;94;96;95;96;95;95;95;95 05:05:20 INFO - PROCESS | 23357 | |8;json-parse-financial;55;56;65;56;56;58;57;80;55;55 05:05:20 INFO - PROCESS | 23357 | |9;json-stringify-tinderbox;58;59;61;59;59;58;58;58;58;59 05:05:20 INFO - PROCESS | 23357 | |10;stanford-crypto-aes;74;74;73;73;73;80;74;74;77;77 05:05:20 INFO - PROCESS | 23357 | |11;stanford-crypto-ccm;118;132;113;128;127;119;115;124;128;128 05:05:20 INFO - PROCESS | 23357 | |12;stanford-crypto-pbkdf2;165;163;168;164;168;171;161;164;168;164 05:05:20 INFO - PROCESS | 23357 | |13;stanford-crypto-sha256-iterative;67;68;67;68;66;65;67;69;68;71 05:05:20 INFO - PROCESS | 23357 | __end_tp_report 05:05:20 INFO - PROCESS | 23357 | __start_cc_report 05:05:20 INFO - PROCESS | 23357 | _x_x_mozilla_cycle_collect,830 05:05:20 INFO - PROCESS | 23357 | __end_cc_report 05:05:20 INFO - PROCESS | 23357 | __startTimestamp1463659520624__endTimestamp 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | ------- Summary: start ------- 05:05:20 INFO - PROCESS | 23357 | Number of tests: 14 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:4.11 (3.7%) stddev-sans-first:4.34 05:05:20 INFO - PROCESS | 23357 | Values: 109.0 111.0 105.0 111.0 113.0 115.0 101.0 111.0 112.0 112.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:20.61 (13.4%) stddev-sans-first:21.82 05:05:20 INFO - PROCESS | 23357 | Values: 153.0 130.0 154.0 180.0 131.0 156.0 151.0 129.0 183.0 126.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 05:05:20 INFO - PROCESS | 23357 | Values: 163.0 163.0 162.0 162.0 162.0 164.0 164.0 163.0 162.0 161.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.54 (49.4%) stddev-sans-first:39.26 05:05:20 INFO - PROCESS | 23357 | Values: 76.0 77.0 78.0 166.0 74.0 76.0 75.0 76.0 164.0 76.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.34 (30.8%) stddev-sans-first:29.40 05:05:20 INFO - PROCESS | 23357 | Values: 93.0 93.0 161.0 92.0 94.0 92.0 150.0 92.0 92.0 140.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:05:20 INFO - PROCESS | 23357 | Values: 118.0 118.0 118.0 117.0 116.0 118.0 118.0 118.0 118.0 118.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:05:20 INFO - PROCESS | 23357 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:05:20 INFO - PROCESS | 23357 | Values: 95.0 95.0 94.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:56.50 stddev:7.86 (13.9%) stddev-sans-first:8.18 05:05:20 INFO - PROCESS | 23357 | Values: 55.0 56.0 65.0 56.0 56.0 58.0 57.0 80.0 55.0 55.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 05:05:20 INFO - PROCESS | 23357 | Values: 58.0 59.0 61.0 59.0 59.0 58.0 58.0 58.0 58.0 59.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.33 (3.1%) stddev-sans-first:2.45 05:05:20 INFO - PROCESS | 23357 | Values: 74.0 74.0 73.0 73.0 73.0 80.0 74.0 74.0 77.0 77.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:127.50 stddev:6.48 (5.1%) stddev-sans-first:6.59 05:05:20 INFO - PROCESS | 23357 | Values: 118.0 132.0 113.0 128.0 127.0 119.0 115.0 124.0 128.0 128.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.50 stddev:3.03 (1.8%) stddev-sans-first:3.20 05:05:20 INFO - PROCESS | 23357 | Values: 165.0 163.0 168.0 164.0 168.0 171.0 161.0 164.0 168.0 164.0 05:05:20 INFO - PROCESS | 23357 | 05:05:20 INFO - PROCESS | 23357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.73 05:05:20 INFO - PROCESS | 23357 | Values: 67.0 68.0 67.0 68.0 66.0 65.0 67.0 69.0 68.0 71.0 05:05:20 INFO - PROCESS | 23357 | -------- Summary: end -------- 05:05:20 INFO - PROCESS | 23357 | 05:05:21 INFO - TEST-INFO | 23357: exit 0 05:05:21 INFO - TEST-OK | kraken | took 60060ms 05:05:21 INFO - SUITE-END | took 1168s 05:05:21 INFO - Completed test suite (00:19:28) 05:05:21 INFO - javascript benchmark 05:05:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.8323083845808, 3403.9149021274466, 3421.7262618990485, 3468.809215493147, 3475.704565111965, 5622.887542249157, 5679.914801277974, 5690.089585666295, 5699.914501282474, 5713.828585142447, 5680.602357834953, 5740.569457290699, 5750.683712395817, 5754.079347304421, 5776.39347868473, 5177.896442071156, 5204.843854684346, 5234.37187537496, 5269.314989051437, 5282.392524859632, 5042.899142017158, 5370.973145134269, 5372.677639341632, 5382.461753824606, 5384.6499977501335, 5056.393232812067, 5155.510226528474, 5161.122609156452, 5178.404483484391, 5198.090334191501, 5181.222816577506, 5213.504717051893, 5219.086659834514, 5223.660462069991, 5224.895502089937, 5188.377394712621, 5206.661566998133, 5259.0796610593, 5296.020236256305, 5310.787568497255, 5270.841874743725, 5382.138857782736, 5446.319210098738, 5508.9724551377385, 5610.0, 6003.8198854034445, 6023.096535519663, 6024.668643224621, 6026.638401695912, 6027.60820546663, 6068.817935461943, 6082.787102451437, 6089.573729838913, 6094.756209751605, 6100.115483254947, 5548.223248745179, 5592.972035139839, 5636.71816409182, 5730.140478928152, 5807.883842323172, 6086.482648974798, 6091.2081429414775, 6124.418180272867, 6130.233720784902, 6135.294441139237, 5861.853453663607, 5878.147668588031, 5900.055991041413, 5901.055831067095, 5950.315713692894, 6023.728932198062, 6052.54605904559, 6052.969735151296, 6058.636481811017, 6086.513078953673, 6012.819615411545, 6017.338092809788, 6019.939800601938, 6028.2766068072115, 6038.245219347582, 5725.370209276976, 5923.229980102646, 5993.700314984233, 6007.759689612367, 6051.425114614105, 4650.279206722963, 4657.208274593328, 4659.324397962277, 4668.906621867543, 4683.7423941682855, 4143.0, 4145.54399016108, 4156.542780294165, 4167.374893765959, 4192.392103145027, 5873.442023007808, 5876.942150412967, 5920.111983202554, 5984.461398474158, 5993.370696076936, 5926.555508336892, 6124.969375153096, 6137.693115344215, 6155.384461553898, 6178.7219575119225, 5842.357340692521, 5845.766169353178, 5846.0, 5850.970745146332, 5883.529317654577, 4911.4106307243355, 4997.650164488524, 5070.163423035158, 5074.13739664258, 5112.182050871843, 6382.329855365213, 6395.16862807832, 6421.646809425526, 6423.0, 6427.421532062137, 5914.7338369774325, 6190.628562286277, 6213.471854892204, 6219.813405597839, 6227.1282020517165, 6282.780102696383, 6344.68276586178, 6394.0, 6397.648129352744, 6406.615603063645, 5883.646981181143, 5909.320428150646, 5917.556183286357, 5934.0, 5950.732217050157, 5886.911696324473, 6016.0, 6025.367336429612, 6031.155638210742, 6129.328227221949, 6003.609765365237, 6007.789727359522, 6008.489278411384, 6025.548083893813, 6049.909251361145, 5954.583179177416, 6008.1588577598295, 6011.098335249748, 6016.8796624068145, 6024.246969128859, 5651.350094738993, 5791.797287094932, 5826.854328641818, 5869.8239052828485, 5896.764129434775, 5956.880862382642, 5966.071953778866, 6022.247219097613, 6030.668313242813, 6038.969805150946, 5862.091375836752, 5871.588988770745, 5879.118132280192, 5879.2944846618675, 5883.61756485827], "value": 5613.075590641444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.5230943709187, 665.3978149774455, 675.3685304240533, 681.454836131095, 691.0084029417783, 33253.16867078321, 41150.58849411509, 41351.0, 41407.58592414075, 41705.3744193837, 44545.0, 45426.7728661357, 45473.77263113688, 45495.77252113743, 45514.544854551445, 8764.298856091513, 8960.372773905796, 8962.0, 8986.910130898672, 8997.280217582611, 8814.955925220396, 8890.511021893793, 8892.510911899843, 8899.73300800977, 8906.73279801607, 9115.772105697344, 9146.588403521857, 9171.037041110687, 9201.263898888074, 9204.0, 9098.272138228926, 9105.089491050841, 9126.680566180152, 9127.132922372364, 9144.954275228647, 9036.412633178888, 9117.361784675075, 9172.495512746797, 9180.8622870657, 9201.493917834516, 44904.3264351035, 45454.31818522692, 45503.0, 45534.0, 45577.316340254925, 3890.649841514249, 3956.3274243378696, 4320.24395730749, 4356.390105385217, 4688.484266730657, 33855.0, 33991.320173596636, 34135.82932085349, 34386.0, 35812.46281305783, 4315.697901146921, 4321.6326612238, 4340.65274778017, 4346.456692913386, 4412.75729834859, 314507.0, 315314.0, 315647.0, 315679.0, 315818.0, 56310.0, 63384.36615633785, 63648.0, 64031.6798416005, 64079.679601601696, 59222.40777592169, 59360.10959835606, 59367.40632593619, 59639.40360596425, 59673.70163149243, 18051.187696553687, 18120.27518899229, 18322.908385457988, 18333.44999649986, 18362.81637183611, 14383.137011779118, 14397.0, 14412.42350305997, 14498.347574359179, 14521.85478145205, 17756.28974840992, 17916.92498450071, 18491.81508184901, 18606.81393186051, 18680.0, 6853.862922741617, 6943.132108486439, 7040.3663670269925, 7047.036848361319, 7047.68285427157, 1109.450821843193, 1134.659602119361, 1156.1271240213753, 1169.8245263210586, 1231.3736047340496, 33706.32587348239, 33990.49014264788, 34204.14489637729, 34322.48516272258, 34354.0, 1259.8803113704184, 1283.6919139406662, 1301.9283939383236, 1311.6293473320402, 1364.8089267502558, 17829.375971840924, 17856.0, 17900.63078888537, 17943.910280448774, 17945.641087178185, 500037.0, 571656.0, 572688.0, 583987.0, 589492.0, 55624.44375556193, 56247.15629265564, 56417.0, 56418.7179064102, 56745.0, 828.5194587139445, 1387.3063468265866, 1563.64817915968, 1573.0718875863524, 1582.3512359932602, 31570.368592628478, 32746.672533274363, 33165.0, 33188.50217246695, 33266.334673305915, 54038.64903377447, 54488.182677260666, 54662.72668636632, 54742.45257547533, 54853.72573137269, 364516.0, 365054.0, 365848.0, 368248.0, 368362.0, 29948.101556953327, 30582.541261881535, 30788.53817192789, 30796.384072318877, 31035.379292413574, 49423.75288123536, 49892.25161622506, 49999.25001125059, 51202.23196652128, 51210.0, 41534.0, 42833.35749963815, 42903.785481073646, 44034.0, 44637.330440044076, 41759.16481670289, 42453.36319955265, 43331.566684332756, 43920.34119488274, 43982.56017439785, 44102.0, 45046.0, 45074.0, 45505.31742023806, 45944.31083533683, 37091.6290837099, 37301.0, 37343.0, 37773.24453510859, 38314.42528362133, 29792.553111703775, 29889.252768680955, 29993.250168745955, 30093.69906300909, 30129.246768830955], "value": 20874.806678629382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.63107281129004, 436.51546783070785, 437.6717461903572, 438.52639149718306, 449.1421385154356, 18430.354937577187, 18684.90657546714, 19193.520161995955, 21135.894320528416, 21223.893880530613, 20257.088431020602, 20638.89680551599, 20646.0, 20761.688574671356, 20850.374488765323, 5720.79977200798, 5785.16115163301, 5836.649801011953, 5871.677057761822, 5913.704314784265, 5853.5902486825935, 5900.52795776339, 5903.0, 5908.379620139866, 5921.082232254007, 5467.781288748445, 5721.971390143043, 5722.570807189478, 5722.685252311121, 5865.736041878125, 5702.885942281152, 5712.057510510782, 5718.628289161191, 6179.69101544921, 6642.800715978528, 5959.553033522503, 5982.192404025444, 6004.6997650117755, 6008.3390827009, 6020.4280593343565, 14432.711345773027, 14453.132812031312, 14781.482648107372, 14823.110613363233, 14891.702165956729, 2456.1771806444863, 2504.3113143885394, 2550.7321731218326, 2745.8330209661012, 2848.473032488996, 10523.368597884151, 10642.255042147053, 10679.893201067967, 10845.783084338269, 10846.783064338748, 2059.8764074155447, 2090.1221486975505, 2104.736907886514, 2121.554473560554, 2159.84881058326, 83489.0, 86515.56742216312, 87843.0, 87993.56003220007, 88223.0, 11683.591074312528, 11909.821352679717, 11959.282443053444, 11963.40182990847, 11992.280463172237, 16961.830381696273, 17045.48863534096, 17096.0, 17164.570885727957, 17181.7422738659, 8998.14517620825, 9104.180623743894, 9201.079892010745, 9285.814283714422, 9289.581968811419, 8750.781230469289, 8902.554872256362, 8924.241439477588, 8996.325275604357, 9007.81984360309, 5048.217526283432, 5154.8969020620125, 5166.199239117943, 5171.5862730981435, 5230.607704422184, 2055.393658870637, 2062.3400511836066, 2122.7771084036262, 2130.2970019893396, 2174.608570457301, 984.2765567308023, 1010.4846528270488, 1054.0, 1118.3290025984506, 1174.0783484964263, 17988.460346189637, 18168.909155454403, 18638.16128274231, 18638.16128274231, 18846.71729924052, 1060.0936199549274, 1070.29895418501, 1090.5342621963048, 1092.2900114925362, 1154.6766905266538, 10605.734856628646, 10778.838317425245, 10832.404217768099, 10842.728931776768, 11026.779464410827, 567553.0, 576844.0, 584904.0, 585577.0, 594057.0, 81616.59191704003, 88665.55667221623, 90225.0, 97039.51480242553, 99394.50302748584, 1130.5929865248504, 1177.1171621284036, 1179.8820117988305, 1190.541641468041, 1191.53530123252, 17254.223559939583, 17411.82588174102, 17430.564235894206, 17577.209025594133, 17595.824041759417, 41066.79466602648, 41650.58349416467, 42003.0, 42465.787671061444, 42651.0, 59766.40233597608, 62924.68537657466, 63277.68361158165, 64054.3594564067, 64079.718405630694, 9384.718458446258, 9474.621015159591, 9515.429074255568, 9558.330916835755, 9612.807743844944, 12063.75872482563, 13240.27178505153, 13272.80090798658, 14279.071860329046, 14326.212058336892, 9416.446286362674, 11879.762404751684, 12496.312702801433, 12533.248005119722, 12617.0, 11910.166288359731, 12017.02652438126, 12117.939410302892, 12291.938540307241, 12506.437210325375, 12499.875001249871, 12524.874751252371, 12692.746145077232, 12731.04517161198, 12840.678983025498, 8920.598573064357, 8971.685990990283, 9086.36395452312, 9173.862392064259, 9509.286803489904, 12284.508619655113, 12478.376081195722, 12532.0, 12547.0, 12628.43172057278], "value": 9674.496756403587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1163.749793794334, 1173.9295642261466, 1255.9246445213284, 1930.9572830671439, 1961.9019049047554, 8444.366672499564, 8547.572621368938, 8629.69796057139, 8649.264812490937, 8754.6935857245, 8869.733907982754, 8954.776130596738, 8984.146506081928, 8992.0, 8996.865047024283, 2461.7292097869263, 2463.864487453189, 2482.429041320497, 2487.502499500098, 2498.525280196766, 2473.307473907309, 2534.087728417768, 2539.1366935242013, 2539.860307683077, 2542.8092893033004, 2413.8431001984904, 2422.1401402502124, 2519.987400062997, 2523.1925783749207, 2525.02786427225, 2486.589712697412, 2508.8745562721883, 2523.7602427769334, 2525.722170561237, 2531.974680253192, 2449.6080627099755, 2471.851688898672, 2502.5245203411478, 2513.4847356291916, 2534.1763926723706, 8867.955660221722, 8890.377673562853, 8925.107489251088, 8942.821143577157, 8947.686830960885, 5390.757415916293, 5461.399246082928, 5496.890062198733, 5499.917501237484, 5528.668279903219, 3628.455731640249, 3666.32173047987, 3707.7589956653, 3743.232637309345, 3751.606081361445, 1235.8455193100863, 1237.591724165394, 1247.5945317771761, 1274.8151518029833, 1312.9934350328283, 12371.876281237162, 12421.75156496865, 12428.378581071001, 12472.937635311766, 12480.063995200397, 4662.0, 4744.810207591727, 4796.544328288807, 4797.2564252540915, 4816.470188279286, 10022.398656080659, 10024.699259022242, 10049.447280399501, 10053.949730251303, 10060.0945914868, 5402.081646120169, 5437.592180586393, 5451.127819548853, 5465.180222966507, 5465.180222966507, 4308.353746937984, 5012.8496145115705, 5092.541671249605, 5106.361704786902, 5112.514311140436, 4125.628693417607, 4154.729942553724, 4165.604267594574, 4169.687273454503, 4171.560811520021, 1265.4179077624397, 1275.4005617359826, 1280.4622058735354, 1297.8377702787152, 1298.9415476303589, 966.7486453521994, 1067.0876400677464, 1069.085931528532, 1089.128697042363, 1094.6442406218011, 6014.428629280212, 6077.9392206078255, 6155.96922015396, 6297.370262973757, 6374.776882809172, 508.1716801613347, 508.63632502760703, 508.8397154896196, 510.04112268934165, 516.1174391790006, 4066.4713587234064, 4213.936790948138, 4236.76697781625, 4240.067185219247, 4251.511076226212, 10672.573097076185, 10968.561257549609, 11118.166137539716, 11153.888461115448, 11163.051140653135, 10248.538815753309, 10526.526306316235, 10978.286411383235, 10992.835107473395, 11001.22991390611, 8370.288525475402, 8393.916060839436, 8406.0, 8434.873476897852, 8458.87311690325, 6104.236970378703, 6248.4688801452385, 6281.685915704288, 6358.77744278948, 6359.55483116196, 9562.18721408688, 9741.220702343937, 9791.559379828068, 9794.16749576294, 9849.064338888082, 10026.398416094766, 10046.346987445793, 10088.848667270144, 10207.642732504326, 10267.640632577824, 7098.858022839618, 7972.760817175494, 8066.193380661887, 8153.103158652425, 8367.205115514016, 8027.0, 8057.0, 8274.544900030556, 8303.294219991369, 8415.368847336353, 7414.740484083031, 7595.658195381332, 7617.7333793319185, 7815.0, 7829.138794732461, 7684.193159718149, 7722.613869306625, 7786.182450842806, 7863.52818830872, 7896.763097107096, 7064.081669382947, 7081.150261968597, 7089.7873063808165, 7099.254578269208, 7109.466789990668, 5199.11615025439, 5374.946250537445, 5443.346798384061, 5474.644148130359, 5525.198846167203, 5243.764030618555, 5389.487998640123, 5490.862728431821, 5510.972445137909, 5548.639338442988], "value": 4696.92262670198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.5214696967427, 371.2815701617371, 371.86984555405604, 374.5243540703305, 382.8774792066536, 6499.512536559753, 6525.771597994071, 6592.802215933523, 6593.439557637601, 6679.098321726566, 6522.249941256757, 6599.604023758578, 6624.304448032959, 6647.966760166192, 6681.23165835929, 5160.819371322004, 5162.483751624845, 5166.0, 5174.767135478913, 5180.11937970544, 5096.337476128098, 5111.667741596784, 5165.38015438148, 5166.741662916858, 5185.637005409623, 5119.308893299412, 5124.948750512484, 5127.051495473331, 5133.307003554528, 5141.383034035921, 5020.849374518771, 5111.642185047048, 5124.795008199668, 5141.742912854361, 5145.125328694131, 4475.060237350161, 4516.706414083107, 4517.096580683843, 4532.252178390595, 4540.568645978627, 6423.518236132309, 6436.002419624966, 6436.903446448307, 6439.162908821823, 6442.484601231937, 5740.08158694611, 5974.6713930733795, 5975.402459754033, 5976.073708575178, 6008.309044459899, 7032.964835175842, 7064.611446370448, 7076.186238582526, 7077.07997960267, 7089.042979197794, 5002.324686167357, 5003.149464591028, 5003.349564556621, 5012.223105418666, 5017.7491125443585, 7339.412846972229, 7340.522866013692, 7353.889691654629, 7409.444291678145, 7420.406367490587, 5043.823466178666, 5120.769565369567, 5160.122779127557, 5178.171492561172, 5184.870378240575, 5174.896502069938, 5204.297419848348, 5230.37235531731, 5238.345206849144, 5246.055709972242, 5951.315598706117, 5954.225950626391, 5971.552133589998, 5973.253343332083, 5975.67133807636, 7025.929740702528, 7117.25268846774, 7123.358897699232, 7162.355388015104, 7171.569705817667, 1837.990810045968, 1861.9813801862078, 1863.5620629152138, 1864.0679660169915, 1864.3661155207294, 1195.557643671847, 1208.8247204155348, 1218.232513516479, 1245.2839617220134, 1258.2010423381219, 6796.898046529306, 6827.873400888897, 6853.828654283583, 6854.0, 6855.520113592101, 7296.343329100407, 7299.671514781848, 7304.342609165201, 7307.926920730831, 7337.74317898871, 6781.220159681699, 6790.0493930849725, 6811.659417029129, 6840.555363901331, 6842.692078856463, 3866.3233934061427, 3918.8628398005935, 3942.8619998299923, 3943.2704949584418, 3979.9403008954887, 7556.773296801105, 7560.659770310349, 7562.697492100365, 7565.092188937363, 7566.924330756622, 7338.743143989935, 7356.337929586363, 7364.96317518409, 7381.261873812576, 7396.815079623052, 7503.0, 7521.661525231269, 7531.736389226351, 7558.206388329256, 7565.659545320474, 7016.508844381048, 7197.784066478014, 7209.279072092959, 7263.382612477999, 7290.599017053901, 7109.715611375694, 7139.571625702474, 7151.642417879189, 7164.283571642794, 7165.3551180394015, 7482.588457634664, 7504.099508058849, 7561.3194812467145, 7563.243675632392, 7568.3945284378215, 5126.948730512796, 5127.846164615067, 5131.4868513148385, 5136.486351364833, 5137.152369858932, 7105.111861017373, 7205.531640443354, 7233.782986510413, 7254.673539690621, 7262.273772622695, 7013.544119632412, 7019.719211231493, 7024.121984751906, 7034.226235114235, 7043.837766768426, 6915.204751453446, 6952.270011648704, 6966.512344136065, 6994.650267486503, 7010.579365238102, 6793.082933803873, 6855.211650660238, 6859.108315918898, 6869.003994420881, 6875.449964002968, 6882.8623427530165, 7049.471289653194, 7051.823704407431, 7071.7878463646175, 7076.964615176891, 6738.629375384205, 6830.043793868763, 6945.270746571739, 7040.753573624898, 7056.682449289691], "value": 5357.23826764814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.2610641794847, 892.6384814150272, 914.6750222213391, 929.4748467116079, 936.9297302702295, 15075.321610527526, 15271.770923436157, 15305.770413443794, 15328.540143795675, 15330.923345383286, 14177.291135443213, 14184.290785460737, 14310.71378572428, 14319.498817541387, 14423.63940901478, 756.3722110648149, 896.9820603587924, 906.8413027720155, 916.2715641065369, 921.7280902133853, 914.8856392950881, 916.8808054952847, 916.9128932751378, 919.2140719684674, 922.1654402765474, 947.7346343023964, 952.119289657068, 953.3326671330062, 954.1889394015101, 956.2541217850088, 942.4627962061628, 944.3483996042709, 946.6923249943795, 946.9147776700061, 948.5541795356206, 697.5291678117301, 702.8840241360169, 703.5602748282323, 705.1679018757864, 706.9081019467487, 14237.715245695028, 14237.715245695132, 14243.786343204756, 14266.144031358048, 14276.500322488662, 14954.40182392703, 14966.925165374212, 15256.923715381352, 15315.387384504607, 15412.229388530528, 11808.52765889372, 11979.580714675032, 12066.0, 12242.204256723284, 12388.938055309756, 4049.6152865477734, 4065.89835254121, 4101.753894766323, 4227.661787057059, 4247.086876321575, 55571.166432503545, 56342.43657563413, 57702.0, 59479.702601486715, 59623.70188149075, 11850.88149118515, 11914.344711040976, 12014.579489717818, 12022.27866328023, 12081.0, 21962.670559941613, 22067.66898496524, 22074.889625552092, 22107.557848842935, 22192.88903555472, 8912.287017038621, 8943.105689431135, 8946.86579701305, 9079.18287354128, 9110.453372797654, 5233.188855727369, 5246.63273570854, 5248.317718696621, 5249.606279529051, 5340.946590534045, 3701.9819549624067, 3775.811209439517, 3777.9244415111543, 3779.848806047782, 3799.2781371539318, 706.9469789765789, 713.400743375567, 718.5401343140394, 720.4344589497219, 736.7716008037526, 630.2909227119491, 740.1266505523533, 743.7805847275067, 748.221849276757, 827.5117680568494, 9648.228141748643, 9849.45827979468, 9966.40201587907, 10040.69877903664, 10134.138598219233, 764.537454839825, 775.5734346109617, 796.2634563029291, 798.964046617892, 820.216693058128, 4446.911061778746, 4611.492735799059, 4615.815367385334, 4679.532046795293, 4714.198586240347, 62206.68896655488, 63278.0, 63446.68276658587, 63759.04361434582, 63883.6805815968, 56964.71517642385, 57163.428365716645, 57557.42442575604, 58872.41127588755, 60076.39923600708, 51611.0, 52829.47170528323, 53466.46533534615, 54644.0, 54667.45332546624, 8922.86615700778, 9055.637774488947, 9182.317018320839, 9339.392939458914, 9445.48049857237, 38622.0, 39760.403593945535, 39999.600003999585, 40593.797031014656, 40738.0, 44006.11987760163, 44165.77917110394, 44421.77789111163, 47900.7604961973, 48136.0, 12855.228686278853, 12950.546730864375, 12978.740425191632, 13222.669433264246, 13307.334633268492, 13682.794758078835, 13948.930255348658, 14150.78773818373, 14449.783253251, 14583.562493125222, 13604.727905441638, 13828.446862125806, 13862.168269903837, 14044.297785110908, 14068.0, 13536.526221582197, 13687.863121368659, 13836.446542138201, 14157.858421415654, 14211.50259740904, 13360.599182024554, 13889.583312500641, 14130.010899237366, 14467.638309042359, 14477.276136192937, 9846.803063938825, 9948.403095814274, 10052.296339256181, 10141.695749127539, 10489.160867130458, 10923.235373523778, 11732.74852343788, 11995.0, 12006.21959572625, 12028.218165819193], "value": 7288.396423719766, "unit": "score"}], "name": "dromaeo_css", "value": 7696.842849989679, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 111.0, 113.0, 115.0, 101.0, 111.0, 112.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 154.0, 180.0, 131.0, 156.0, 151.0, 129.0, 183.0, 126.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 162.0, 164.0, 164.0, 163.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 166.0, 74.0, 76.0, 75.0, 76.0, 164.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 161.0, 92.0, 94.0, 92.0, 150.0, 92.0, 92.0, 140.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 116.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 65.0, 56.0, 56.0, 58.0, 57.0, 80.0, 55.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 61.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 73.0, 80.0, 74.0, 74.0, 77.0, 77.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 132.0, 113.0, 128.0, 127.0, 119.0, 115.0, 124.0, 128.0, 128.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 168.0, 164.0, 168.0, 171.0, 161.0, 164.0, 168.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 66.0, 65.0, 67.0, 69.0, 68.0, 71.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1534.2, "alertThreshold": 2.0}]} 05:05:21 INFO - Return code: 0 05:05:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:05:21 ERROR - # TBPL SUCCESS # 05:05:21 INFO - Running post-action listener: _resource_record_post_action 05:05:21 INFO - Running post-run listener: _resource_record_post_run 05:05:22 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 334376960; Read time: 0; Write time: 191096 05:05:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 81498112; Read time: 0; Write time: 38432 05:05:22 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 252878848; Read time: 0; Write time: 152664 05:05:22 INFO - Running post-run listener: _upload_blobber_files 05:05:22 INFO - Blob upload gear active. 05:05:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:05:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:05:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:24 INFO - (blobuploader) - INFO - Done attempting. 05:05:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:05:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:25 INFO - (blobuploader) - INFO - Done attempting. 05:05:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:25 INFO - Return code: 0 05:05:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a773c74ee6743d7fc69e981319d6083f602313c8a6f4d150be95f0cbdcb97aeaf27c2f54b84138e2ff05b7467d0f3f4ba121f715e563cb5f6aa8882c6d8b315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d76da44927786a7f1e8da19968184c0d82f4ab41f27f3c19f456a7bd9165e196f36a984c942a44733345dc47ebd4998a750ceeb0cdda13978d065a50145e973f"} 05:05:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:25 INFO - Contents: 05:05:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a773c74ee6743d7fc69e981319d6083f602313c8a6f4d150be95f0cbdcb97aeaf27c2f54b84138e2ff05b7467d0f3f4ba121f715e563cb5f6aa8882c6d8b315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d76da44927786a7f1e8da19968184c0d82f4ab41f27f3c19f456a7bd9165e196f36a984c942a44733345dc47ebd4998a750ceeb0cdda13978d065a50145e973f"} 05:05:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:25 INFO - Copying logs to upload dir... 05:05:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.559460 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 05:05:24.398796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:24.402347) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 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/8a773c74ee6743d7fc69e981319d6083f602313c8a6f4d150be95f0cbdcb97aeaf27c2f54b84138e2ff05b7467d0f3f4ba121f715e563cb5f6aa8882c6d8b315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d76da44927786a7f1e8da19968184c0d82f4ab41f27f3c19f456a7bd9165e196f36a984c942a44733345dc47ebd4998a750ceeb0cdda13978d065a50145e973f"} build_url:https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/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/8a773c74ee6743d7fc69e981319d6083f602313c8a6f4d150be95f0cbdcb97aeaf27c2f54b84138e2ff05b7467d0f3f4ba121f715e563cb5f6aa8882c6d8b315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d76da44927786a7f1e8da19968184c0d82f4ab41f27f3c19f456a7bd9165e196f36a984c942a44733345dc47ebd4998a750ceeb0cdda13978d065a50145e973f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:24.431273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:24.431630) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1463657271.217715-1983232824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004742 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:24.483473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:05:24.483801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:05:24.484124) ========= ========= Total master_lag: 0.13 =========