builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1457727364.36 results: success (0) buildid: 20160311092215 builduid: ce15307925c14407b0ee62bcd42f958e revision: 453eb239f97ecc3d3aa7be7823f936668670366e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.364188) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.364682) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.364986) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006400 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.396002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.396326) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.454851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.455113) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.503734) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.504010) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.504368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.504653) ========= 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 12:16:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-03-11 12:16:04 (23.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.603279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.603563) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084473 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.699572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:04.699877) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 453eb239f97ecc3d3aa7be7823f936668670366e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 453eb239f97ecc3d3aa7be7823f936668670366e --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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 12:16:04,855 truncating revision to first 12 chars 2016-03-11 12:16:04,855 Setting DEBUG logging. 2016-03-11 12:16:04,855 attempt 1/10 2016-03-11 12:16:04,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/453eb239f97e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 12:16:05,114 unpacking tar archive at: date-453eb239f97e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:05.296917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:05.297250) ========= echo 453eb239f97ecc3d3aa7be7823f936668670366e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'453eb239f97ecc3d3aa7be7823f936668670366e'] 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 453eb239f97ecc3d3aa7be7823f936668670366e program finished with exit code 0 elapsedTime=0.004667 script_repo_revision: '453eb239f97ecc3d3aa7be7823f936668670366e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:05.347532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:05.347822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:16:05.359622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 12:16:05.359923) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-Non-PGO'] 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:05 INFO - MultiFileLogger online at 20160311 12:16:05 in /builds/slave/test 12:16:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 12:16:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:05 INFO - {'append_to_log': False, 12:16:05 INFO - 'base_work_dir': '/builds/slave/test', 12:16:05 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:16:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:05 INFO - 'branch': 'Date-Non-PGO', 12:16:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:05 INFO - 'config_files': ('talos/linux_config.py',), 12:16:05 INFO - 'default_actions': ('clobber', 12:16:05 INFO - 'read-buildbot-config', 12:16:05 INFO - 'download-and-extract', 12:16:05 INFO - 'populate-webroot', 12:16:05 INFO - 'create-virtualenv', 12:16:05 INFO - 'install', 12:16:05 INFO - 'run-tests'), 12:16:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:05 INFO - 'download_minidump_stackwalk': True, 12:16:05 INFO - 'download_symbols': 'ondemand', 12:16:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:05 INFO - 'installer_path': 'installer.exe', 12:16:05 INFO - 'log_level': 'info', 12:16:05 INFO - 'log_name': 'talos', 12:16:05 INFO - 'log_to_console': True, 12:16:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:05 INFO - 'opt_config_files': (), 12:16:05 INFO - 'pip_index': False, 12:16:05 INFO - 'sps_profile': False, 12:16:05 INFO - 'sps_profile_interval': 0, 12:16:05 INFO - 'suite': 'dromaeojs', 12:16:05 INFO - 'system_bits': '32', 12:16:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:05 INFO - 'title': 'talos-linux64-ix-028', 12:16:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:05 INFO - 'use_talos_json': True, 12:16:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:05 INFO - 'work_dir': 'build'} 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running clobber step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: clobber 12:16:05 INFO - rmtree: /builds/slave/test/build 12:16:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:07 INFO - Running post-action listener: _resource_record_post_action 12:16:07 INFO - ##### 12:16:07 INFO - ##### Running read-buildbot-config step. 12:16:07 INFO - ##### 12:16:07 INFO - Running pre-action listener: _resource_record_pre_action 12:16:07 INFO - Running main action method: read_buildbot_config 12:16:07 INFO - Using buildbot properties: 12:16:07 INFO - { 12:16:07 INFO - "project": "", 12:16:07 INFO - "product": "firefox", 12:16:07 INFO - "script_repo_revision": "production", 12:16:07 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 12:16:07 INFO - "repository": "", 12:16:07 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 12:16:07 INFO - "buildid": "20160311092215", 12:16:07 INFO - "pgo_build": "False", 12:16:07 INFO - "basedir": "/builds/slave/test", 12:16:07 INFO - "buildnumber": 3, 12:16:07 INFO - "slavename": "talos-linux64-ix-028", 12:16:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:07 INFO - "platform": "ubuntu64_hw", 12:16:07 INFO - "scheduler": "tests-date-linux64-talos", 12:16:07 INFO - "branch": "date", 12:16:07 INFO - "repo_path": "projects/date", 12:16:07 INFO - "revision": "453eb239f97ecc3d3aa7be7823f936668670366e", 12:16:07 INFO - "stage_platform": "linux64", 12:16:07 INFO - "builduid": "ce15307925c14407b0ee62bcd42f958e", 12:16:07 INFO - "slavebuilddir": "test" 12:16:07 INFO - } 12:16:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:16:07 INFO - Running post-action listener: _resource_record_post_action 12:16:07 INFO - ##### 12:16:07 INFO - ##### Running download-and-extract step. 12:16:07 INFO - ##### 12:16:07 INFO - Running pre-action listener: _resource_record_pre_action 12:16:07 INFO - Running main action method: download_and_extract 12:16:07 INFO - mkdir: /builds/slave/test/build/tests 12:16:07 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')]} 12:16:07 INFO - https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/test_packages.json 12:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/test_packages.json 12:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:12 INFO - Downloaded 1412 bytes. 12:16:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:12 INFO - Using the following test package requirements: 12:16:12 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:16:12 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:12 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:16:12 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'jsshell-linux-x86_64.zip'], 12:16:12 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:12 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:16:12 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:16:12 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:16:12 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:12 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:16:12 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:16:12 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:12 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:12 INFO - https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:16 INFO - Downloaded 23091541 bytes. 12:16:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:16:17 INFO - Return code: 0 12:16:17 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:16: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')]} 12:16:17 INFO - https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:19 INFO - Downloaded 23091541 bytes. 12:16:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:16:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:16:20 INFO - Return code: 0 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:16:21 INFO - Downloaded 10706668 bytes. 12:16:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:16:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:16:21 INFO - Return code: 0 12:16:21 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')]} 12:16:21 INFO - https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:16:23 INFO - Downloaded 52853555 bytes. 12:16:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:16:23 INFO - mkdir: /builds/slave/test/properties 12:16:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:23 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:23 INFO - Contents: 12:16:23 INFO - build_url:https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:16:24 INFO - Running post-action listener: _resource_record_post_action 12:16:24 INFO - Running post-action listener: set_extra_try_arguments 12:16:24 INFO - ##### 12:16:24 INFO - ##### Running populate-webroot step. 12:16:24 INFO - ##### 12:16:24 INFO - Running pre-action listener: _resource_record_pre_action 12:16:24 INFO - Running main action method: populate_webroot 12:16:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:24 INFO - '--tppagecycles', 12:16:24 INFO - '7'], 12:16:24 INFO - 'tests': ['tsvgm']}}, 12:16:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'tests': ['damp', 'tps']}, 12:16:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['damp', 'tps']}, 12:16:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:24 INFO - 'other': {'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'other_l64': {'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:24 INFO - 'ts_paint', 12:16:24 INFO - 'tpaint', 12:16:24 INFO - 'sessionrestore', 12:16:24 INFO - 'sessionrestore_no_auto_restore']}, 12:16:24 INFO - 'svgr': {'tests': ['tsvgx', 12:16:24 INFO - 'tsvgr_opacity', 12:16:24 INFO - 'tart', 12:16:24 INFO - 'tscrollx', 12:16:24 INFO - 'cart']}, 12:16:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['tsvgx', 12:16:24 INFO - 'tsvgr_opacity', 12:16:24 INFO - 'tart', 12:16:24 INFO - 'tscrollx', 12:16:24 INFO - 'cart']}, 12:16:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'tests': ['tp5o']}, 12:16:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'talos_options': ['--e10s'], 12:16:24 INFO - 'tests': ['tp5o']}, 12:16:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'talos_options': ['--xperf_path', 12:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:24 INFO - 'tests': ['tp5n']}, 12:16:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:24 INFO - 'talos_options': ['--e10s', 12:16:24 INFO - '--xperf_path', 12:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:24 INFO - 'tests': ['tp5n']}}, 12:16:24 INFO - 'talos.zip': {'path': '', 12:16:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:24 INFO - Running post-action listener: _resource_record_post_action 12:16:24 INFO - ##### 12:16:24 INFO - ##### Running create-virtualenv step. 12:16:24 INFO - ##### 12:16:24 INFO - Running pre-action listener: _resource_record_pre_action 12:16:24 INFO - Running main action method: create_virtualenv 12:16:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:24 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 12:16:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:24 INFO - Using real prefix '/usr' 12:16:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:26 INFO - Installing pip.................done. 12:16:26 INFO - Return code: 0 12:16:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:26 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:26 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 12:16:26 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 12:16:26 INFO - Using env: {'DISPLAY': ':0', 12:16:26 INFO - 'HOME': '/home/cltbld', 12:16:26 INFO - 'LANG': 'en_US.UTF-8', 12:16:26 INFO - 'LANGUAGE': 'en_US:en', 12:16:26 INFO - 'LOGNAME': 'cltbld', 12:16:26 INFO - 'MAIL': '/var/mail/cltbld', 12:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:26 INFO - 'MOZ_NO_REMOTE': '1', 12:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:26 INFO - 'NO_EM_RESTART': '1', 12:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:26 INFO - 'PWD': '/builds/slave/test', 12:16:26 INFO - 'SHELL': '/bin/bash', 12:16:26 INFO - 'SHLVL': '1', 12:16:26 INFO - 'TERM': 'linux', 12:16:26 INFO - 'TMOUT': '86400', 12:16:26 INFO - 'USER': 'cltbld', 12:16:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:26 INFO - '_': '/tools/buildbot/bin/python'} 12:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:27 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 12:16:27 INFO - Cleaning up... 12:16:27 INFO - Return code: 0 12:16:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:16:27 INFO - Using env: {'DISPLAY': ':0', 12:16:27 INFO - 'HOME': '/home/cltbld', 12:16:27 INFO - 'LANG': 'en_US.UTF-8', 12:16:27 INFO - 'LANGUAGE': 'en_US:en', 12:16:27 INFO - 'LOGNAME': 'cltbld', 12:16:27 INFO - 'MAIL': '/var/mail/cltbld', 12:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:27 INFO - 'MOZ_NO_REMOTE': '1', 12:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:27 INFO - 'NO_EM_RESTART': '1', 12:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:27 INFO - 'PWD': '/builds/slave/test', 12:16:27 INFO - 'SHELL': '/bin/bash', 12:16:27 INFO - 'SHLVL': '1', 12:16:27 INFO - 'TERM': 'linux', 12:16:27 INFO - 'TMOUT': '86400', 12:16:27 INFO - 'USER': 'cltbld', 12:16:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:27 INFO - '_': '/tools/buildbot/bin/python'} 12:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:27 INFO - Downloading/unpacking psutil>=0.7.1 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:29 INFO - Installing collected packages: psutil 12:16:29 INFO - Running setup.py install for psutil 12:16:29 INFO - building 'psutil._psutil_linux' extension 12:16:29 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 12:16:29 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 12:16:29 INFO - building 'psutil._psutil_posix' extension 12:16:29 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 12:16:29 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 12:16:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:29 INFO - Successfully installed psutil 12:16:29 INFO - Cleaning up... 12:16:30 INFO - Return code: 0 12:16:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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', '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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:16: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 mozsystemmonitor==0.0.0 12:16:30 INFO - Using env: {'DISPLAY': ':0', 12:16:30 INFO - 'HOME': '/home/cltbld', 12:16:30 INFO - 'LANG': 'en_US.UTF-8', 12:16:30 INFO - 'LANGUAGE': 'en_US:en', 12:16:30 INFO - 'LOGNAME': 'cltbld', 12:16:30 INFO - 'MAIL': '/var/mail/cltbld', 12:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:30 INFO - 'MOZ_NO_REMOTE': '1', 12:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:30 INFO - 'NO_EM_RESTART': '1', 12:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:30 INFO - 'PWD': '/builds/slave/test', 12:16:30 INFO - 'SHELL': '/bin/bash', 12:16:30 INFO - 'SHLVL': '1', 12:16:30 INFO - 'TERM': 'linux', 12:16:30 INFO - 'TMOUT': '86400', 12:16:30 INFO - 'USER': 'cltbld', 12:16:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:30 INFO - '_': '/tools/buildbot/bin/python'} 12:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:31 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 12:16:31 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 12:16:31 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 12:16:31 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 12:16:31 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 12:16:31 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 12:16:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:32 INFO - Installing collected packages: mozsystemmonitor 12:16:32 INFO - Running setup.py install for mozsystemmonitor 12:16:33 INFO - Successfully installed mozsystemmonitor 12:16:33 INFO - Cleaning up... 12:16:33 INFO - Return code: 0 12:16:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:33 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')]} 12:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:33 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')]} 12:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:33 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:33 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 12:16:33 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 12:16:33 INFO - Using env: {'DISPLAY': ':0', 12:16:33 INFO - 'HOME': '/home/cltbld', 12:16:33 INFO - 'LANG': 'en_US.UTF-8', 12:16:33 INFO - 'LANGUAGE': 'en_US:en', 12:16:33 INFO - 'LOGNAME': 'cltbld', 12:16:33 INFO - 'MAIL': '/var/mail/cltbld', 12:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:33 INFO - 'MOZ_NO_REMOTE': '1', 12:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:33 INFO - 'NO_EM_RESTART': '1', 12:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:33 INFO - 'PWD': '/builds/slave/test', 12:16:33 INFO - 'SHELL': '/bin/bash', 12:16:33 INFO - 'SHLVL': '1', 12:16:33 INFO - 'TERM': 'linux', 12:16:33 INFO - 'TMOUT': '86400', 12:16:33 INFO - 'USER': 'cltbld', 12:16:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:33 INFO - '_': '/tools/buildbot/bin/python'} 12:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16: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 12:16:35 INFO - Downloading docopt-0.6.1.tar.gz 12:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:35 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:35 INFO - Running setup.py install for blobuploader 12:16:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:35 INFO - Running setup.py install for requests 12:16:36 INFO - Running setup.py install for docopt 12:16:36 INFO - Successfully installed blobuploader requests docopt 12:16:36 INFO - Cleaning up... 12:16:36 INFO - Return code: 0 12:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:36 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:36 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 12:16:36 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 12:16:36 INFO - Using env: {'DISPLAY': ':0', 12:16:36 INFO - 'HOME': '/home/cltbld', 12:16:36 INFO - 'LANG': 'en_US.UTF-8', 12:16:36 INFO - 'LANGUAGE': 'en_US:en', 12:16:36 INFO - 'LOGNAME': 'cltbld', 12:16:36 INFO - 'MAIL': '/var/mail/cltbld', 12:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:36 INFO - 'MOZ_NO_REMOTE': '1', 12:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:36 INFO - 'NO_EM_RESTART': '1', 12:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:36 INFO - 'PWD': '/builds/slave/test', 12:16:36 INFO - 'SHELL': '/bin/bash', 12:16:36 INFO - 'SHLVL': '1', 12:16:36 INFO - 'TERM': 'linux', 12:16:36 INFO - 'TMOUT': '86400', 12:16:36 INFO - 'USER': 'cltbld', 12:16:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:36 INFO - '_': '/tools/buildbot/bin/python'} 12:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:36 INFO - Running setup.py (path:/tmp/pip-ShN4aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:36 INFO - Running setup.py (path:/tmp/pip-m9gcUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:36 INFO - Running setup.py (path:/tmp/pip-dcyhSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:36 INFO - Running setup.py (path:/tmp/pip-NlXo97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:36 INFO - Running setup.py (path:/tmp/pip-7G0piz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:37 INFO - Running setup.py (path:/tmp/pip-STXnTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:37 INFO - Running setup.py (path:/tmp/pip-tCrVqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:37 INFO - Running setup.py (path:/tmp/pip-BdPTWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:37 INFO - Running setup.py (path:/tmp/pip-5uLqXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:37 INFO - Running setup.py (path:/tmp/pip-_BAsqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:37 INFO - Running setup.py (path:/tmp/pip-sdZHqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:37 INFO - Running setup.py (path:/tmp/pip-Mdx5_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:37 INFO - Running setup.py (path:/tmp/pip-5PijL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:37 INFO - Running setup.py (path:/tmp/pip-JrNwiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:37 INFO - Running setup.py (path:/tmp/pip-G0Yeip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:37 INFO - Running setup.py (path:/tmp/pip-COeAbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:37 INFO - Running setup.py (path:/tmp/pip-vymywG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:37 INFO - Running setup.py install for manifestparser 12:16:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:37 INFO - Running setup.py install for mozcrash 12:16:38 INFO - Running setup.py install for mozdebug 12:16:38 INFO - Running setup.py install for mozdevice 12:16:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Running setup.py install for mozfile 12:16:38 INFO - Running setup.py install for mozhttpd 12:16:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Running setup.py install for mozinfo 12:16:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Running setup.py install for mozInstall 12:16:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Running setup.py install for mozleak 12:16:38 INFO - Running setup.py install for mozlog 12:16:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:38 INFO - Running setup.py install for moznetwork 12:16:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Running setup.py install for mozprocess 12:16:39 INFO - Running setup.py install for mozprofile 12:16:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Running setup.py install for mozrunner 12:16:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Running setup.py install for mozscreenshot 12:16:39 INFO - Running setup.py install for moztest 12:16:39 INFO - Running setup.py install for mozversion 12:16:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:39 INFO - Cleaning up... 12:16:39 INFO - Return code: 0 12:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:39 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:39 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 12:16:39 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 12:16:39 INFO - Using env: {'DISPLAY': ':0', 12:16:39 INFO - 'HOME': '/home/cltbld', 12:16:39 INFO - 'LANG': 'en_US.UTF-8', 12:16:39 INFO - 'LANGUAGE': 'en_US:en', 12:16:39 INFO - 'LOGNAME': 'cltbld', 12:16:39 INFO - 'MAIL': '/var/mail/cltbld', 12:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:39 INFO - 'MOZ_NO_REMOTE': '1', 12:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:39 INFO - 'NO_EM_RESTART': '1', 12:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:39 INFO - 'PWD': '/builds/slave/test', 12:16:39 INFO - 'SHELL': '/bin/bash', 12:16:39 INFO - 'SHLVL': '1', 12:16:39 INFO - 'TERM': 'linux', 12:16:39 INFO - 'TMOUT': '86400', 12:16:39 INFO - 'USER': 'cltbld', 12:16:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:39 INFO - '_': '/tools/buildbot/bin/python'} 12:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:39 INFO - Running setup.py (path:/tmp/pip-eO0mjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:39 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)) 12:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:39 INFO - Running setup.py (path:/tmp/pip-AsMH_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:40 INFO - Running setup.py (path:/tmp/pip-e_sBsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:40 INFO - Running setup.py (path:/tmp/pip-YqJayA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:40 INFO - Running setup.py (path:/tmp/pip-G1ZHNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:40 INFO - Running setup.py (path:/tmp/pip-CV57xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:40 INFO - Running setup.py (path:/tmp/pip-4PTAhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:40 INFO - Running setup.py (path:/tmp/pip-bR6Hsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:40 INFO - Running setup.py (path:/tmp/pip-o0vb19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:40 INFO - Running setup.py (path:/tmp/pip-Em0iFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:40 INFO - Running setup.py (path:/tmp/pip-lYBCRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:40 INFO - Running setup.py (path:/tmp/pip-YrmslJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:40 INFO - Running setup.py (path:/tmp/pip-pFk1_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:40 INFO - Running setup.py (path:/tmp/pip-DZf0eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:40 INFO - Running setup.py (path:/tmp/pip-2PL174-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:40 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)) 12:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:40 INFO - Running setup.py (path:/tmp/pip-keneVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:41 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)) 12:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:41 INFO - Running setup.py (path:/tmp/pip-YePPiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:41 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)) 12:16:41 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:41 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:41 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)) 12:16:41 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)) 12:16:41 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)) 12:16:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:41 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 12:16:42 INFO - Downloading blessings-1.6.tar.gz 12:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:43 INFO - Installing collected packages: blessings 12:16:43 INFO - Running setup.py install for blessings 12:16:43 INFO - Successfully installed blessings 12:16:43 INFO - Cleaning up... 12:16:43 INFO - Return code: 0 12:16:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:43 INFO - Reading from file tmpfile_stdout 12:16:43 INFO - Current package versions: 12:16:43 INFO - argparse == 1.2.1 12:16:43 INFO - blessings == 1.6 12:16:43 INFO - blobuploader == 1.2.4 12:16:43 INFO - docopt == 0.6.1 12:16:43 INFO - manifestparser == 1.1 12:16:43 INFO - mozInstall == 1.12 12:16:43 INFO - mozcrash == 0.16 12:16:43 INFO - mozdebug == 0.1 12:16:43 INFO - mozdevice == 0.48 12:16:43 INFO - mozfile == 1.2 12:16:43 INFO - mozhttpd == 0.7 12:16:43 INFO - mozinfo == 0.9 12:16:43 INFO - mozleak == 0.1 12:16:43 INFO - mozlog == 3.1 12:16:43 INFO - moznetwork == 0.27 12:16:43 INFO - mozprocess == 0.22 12:16:43 INFO - mozprofile == 0.28 12:16:43 INFO - mozrunner == 6.11 12:16:43 INFO - mozscreenshot == 0.1 12:16:43 INFO - mozsystemmonitor == 0.0 12:16:43 INFO - moztest == 0.7 12:16:43 INFO - mozversion == 1.4 12:16:43 INFO - psutil == 3.1.1 12:16:43 INFO - requests == 1.2.3 12:16:43 INFO - wsgiref == 0.1.2 12:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:43 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')]} 12:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:43 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')]} 12:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:43 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:43 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 12:16:43 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 12:16:43 INFO - Using env: {'DISPLAY': ':0', 12:16:43 INFO - 'HOME': '/home/cltbld', 12:16:43 INFO - 'LANG': 'en_US.UTF-8', 12:16:43 INFO - 'LANGUAGE': 'en_US:en', 12:16:43 INFO - 'LOGNAME': 'cltbld', 12:16:43 INFO - 'MAIL': '/var/mail/cltbld', 12:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:43 INFO - 'MOZ_NO_REMOTE': '1', 12:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:43 INFO - 'NO_EM_RESTART': '1', 12:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:43 INFO - 'PWD': '/builds/slave/test', 12:16:43 INFO - 'SHELL': '/bin/bash', 12:16:43 INFO - 'SHLVL': '1', 12:16:43 INFO - 'TERM': 'linux', 12:16:43 INFO - 'TMOUT': '86400', 12:16:43 INFO - 'USER': 'cltbld', 12:16:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:43 INFO - '_': '/tools/buildbot/bin/python'} 12:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 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)) 12:16:43 INFO - Cleaning up... 12:16:43 INFO - Return code: 0 12:16:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:16:43 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')]} 12:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:43 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')]} 12:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:43 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 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:43 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 12:16:43 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 12:16:43 INFO - Using env: {'DISPLAY': ':0', 12:16:43 INFO - 'HOME': '/home/cltbld', 12:16:43 INFO - 'LANG': 'en_US.UTF-8', 12:16:43 INFO - 'LANGUAGE': 'en_US:en', 12:16:43 INFO - 'LOGNAME': 'cltbld', 12:16:43 INFO - 'MAIL': '/var/mail/cltbld', 12:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:43 INFO - 'MOZ_NO_REMOTE': '1', 12:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:43 INFO - 'NO_EM_RESTART': '1', 12:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:43 INFO - 'PWD': '/builds/slave/test', 12:16:43 INFO - 'SHELL': '/bin/bash', 12:16:43 INFO - 'SHLVL': '1', 12:16:43 INFO - 'TERM': 'linux', 12:16:43 INFO - 'TMOUT': '86400', 12:16:43 INFO - 'USER': 'cltbld', 12:16:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:43 INFO - '_': '/tools/buildbot/bin/python'} 12:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:43 INFO - Downloading/unpacking jsonschema 12:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:16:45 INFO - Downloading/unpacking functools32 (from jsonschema) 12:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:45 INFO - Downloading functools32-3.2.3-2.tar.gz 12:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:16:45 INFO - warning: no files found matching '*.txt' 12:16:45 INFO - no previously-included directories found matching 'build' 12:16:45 INFO - no previously-included directories found matching 'dist' 12:16:45 INFO - no previously-included directories found matching '.git*' 12:16:45 INFO - Installing collected packages: jsonschema, functools32 12:16:45 INFO - Running setup.py install for functools32 12:16:46 INFO - warning: no files found matching '*.txt' 12:16:46 INFO - no previously-included directories found matching 'build' 12:16:46 INFO - no previously-included directories found matching 'dist' 12:16:46 INFO - no previously-included directories found matching '.git*' 12:16:46 INFO - Successfully installed jsonschema functools32 12:16:46 INFO - Cleaning up... 12:16:46 INFO - Return code: 0 12:16:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd878c8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, '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': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', '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 12:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:16:46 INFO - Using env: {'DISPLAY': ':0', 12:16:46 INFO - 'HOME': '/home/cltbld', 12:16:46 INFO - 'LANG': 'en_US.UTF-8', 12:16:46 INFO - 'LANGUAGE': 'en_US:en', 12:16:46 INFO - 'LOGNAME': 'cltbld', 12:16:46 INFO - 'MAIL': '/var/mail/cltbld', 12:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:46 INFO - 'MOZ_NO_REMOTE': '1', 12:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:46 INFO - 'NO_EM_RESTART': '1', 12:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:46 INFO - 'PWD': '/builds/slave/test', 12:16:46 INFO - 'SHELL': '/bin/bash', 12:16:46 INFO - 'SHLVL': '1', 12:16:46 INFO - 'TERM': 'linux', 12:16:46 INFO - 'TMOUT': '86400', 12:16:46 INFO - 'USER': 'cltbld', 12:16:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:46 INFO - '_': '/tools/buildbot/bin/python'} 12:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:46 INFO - Downloading/unpacking flake8 12:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:16:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:16:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 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 12:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:16:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:48 INFO - no previously-included directories found matching 'docs/_build' 12:16:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:16:48 INFO - Running setup.py install for pep8 12:16:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:16:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:16:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:16:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:16:48 INFO - no previously-included directories found matching 'docs/_build' 12:16:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:16:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:16:49 INFO - Cleaning up... 12:16:49 INFO - Return code: 0 12:16:49 INFO - Running post-action listener: _resource_record_post_action 12:16:49 INFO - Running post-action listener: _start_resource_monitoring 12:16:49 INFO - Starting resource monitoring. 12:16:49 INFO - ##### 12:16:49 INFO - ##### Running install step. 12:16:49 INFO - ##### 12:16:49 INFO - Running pre-action listener: _resource_record_pre_action 12:16:49 INFO - Running main action method: install 12:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:49 INFO - Reading from file tmpfile_stdout 12:16:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:49 INFO - Reading from file tmpfile_stdout 12:16:49 INFO - Output received: 12:16:49 INFO - Usage: mozinstall [options] installer 12:16:49 INFO - Options: 12:16:49 INFO - -h, --help show this help message and exit 12:16:49 INFO - -d DEST, --destination=DEST 12:16:49 INFO - Directory to install application into. [default: 12:16:49 INFO - "/builds/slave/test"] 12:16:49 INFO - --app=APP Application being installed. [default: firefox] 12:16:49 INFO - mkdir: /builds/slave/test/build/application 12:16:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:17:01 INFO - Reading from file tmpfile_stdout 12:17:01 INFO - Output received: 12:17:01 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:01 INFO - Running post-action listener: _resource_record_post_action 12:17:01 INFO - ##### 12:17:01 INFO - ##### Running run-tests step. 12:17:01 INFO - ##### 12:17:01 INFO - Running pre-action listener: _resource_record_pre_action 12:17:01 INFO - Running main action method: run_tests 12:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:01 INFO - Python 2.7.3 12:17:01 INFO - Return code: 0 12:17:01 INFO - grabbing minidump binary from tooltool 12:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:01 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 0x28bb430>, '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 0x2826f30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28273c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:01 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 12:17:01 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 12:17:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:01 INFO - Return code: 0 12:17:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:17:03 INFO - Return code: 0 12:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:17:03 INFO - Using env: {'DISPLAY': ':0', 12:17:03 INFO - 'HOME': '/home/cltbld', 12:17:03 INFO - 'LANG': 'en_US.UTF-8', 12:17:03 INFO - 'LANGUAGE': 'en_US:en', 12:17:03 INFO - 'LOGNAME': 'cltbld', 12:17:03 INFO - 'MAIL': '/var/mail/cltbld', 12:17:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:03 INFO - 'MOZ_NO_REMOTE': '1', 12:17:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:03 INFO - 'NO_EM_RESTART': '1', 12:17:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:03 INFO - 'PWD': '/builds/slave/test', 12:17:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:03 INFO - 'SHELL': '/bin/bash', 12:17:03 INFO - 'SHLVL': '1', 12:17:03 INFO - 'TERM': 'linux', 12:17:03 INFO - 'TMOUT': '86400', 12:17:03 INFO - 'USER': 'cltbld', 12:17:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799', 12:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:03 INFO - '_': '/tools/buildbot/bin/python'} 12:17:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:17:03 INFO - mozversion application_buildid: 20160311092215 12:17:03 INFO - mozversion application_changeset: 453eb239f97ecc3d3aa7be7823f936668670366e 12:17:03 INFO - mozversion application_display_name: Firefox 12:17:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:03 INFO - mozversion application_name: Firefox 12:17:03 INFO - mozversion application_remotingname: firefox 12:17:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:17:03 INFO - mozversion application_vendor: Mozilla 12:17:03 INFO - mozversion application_version: 46.0 12:17:03 INFO - mozversion platform_buildid: 20160311092215 12:17:03 INFO - mozversion platform_changeset: 453eb239f97ecc3d3aa7be7823f936668670366e 12:17:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:17:03 INFO - mozversion platform_version: 46.0 12:17:03 INFO - using testdate: 1457727423 12:17:03 INFO - actual date: 1457727423 12:17:03 INFO - starting webserver on 'localhost:43256' 12:17:03 INFO - SUITE-START | Running 3 tests 12:17:03 INFO - TEST-START | dromaeo_css 12:17:03 INFO - operating with platform_type : linux_ 12:17:03 INFO - Initialising browser for dromaeo_css test... 12:17:03 INFO - TEST-INFO | started process 10795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwOSip/profile http://localhost:43256/getInfo.html) 12:17:07 INFO - PROCESS | 10795 | __metrics Screen width/height:1600/1200 12:17:07 INFO - PROCESS | 10795 | colorDepth:24 12:17:07 INFO - PROCESS | 10795 | Browser inner width/height: 1024/697 12:17:07 INFO - PROCESS | 10795 | __metrics 12:17:07 INFO - PROCESS | 10795 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:08 INFO - TEST-INFO | 10795: exit 0 12:17:08 INFO - Browser initialized. 12:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 12:17:08 INFO - TEST-INFO | started process 10880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwOSip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:20 INFO - PROCESS | 10880 | RSS: Main: 136318976 12:17:20 INFO - PROCESS | 10880 | 12:18:11 INFO - PROCESS | 10880 | 1457727491260 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] 12:20:19 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43256/tests/dromaeo/cssquery-ext.html) 12:20:20 INFO - PROCESS | 10880 | RSS: Main: 203722752 12:20:20 INFO - PROCESS | 10880 | 12:23:22 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-ext.html (next: http://localhost:43256/tests/dromaeo/cssquery-jquery.html) 12:23:22 INFO - PROCESS | 10880 | RSS: Main: 212615168 12:23:22 INFO - PROCESS | 10880 | 12:26:24 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43256/tests/dromaeo/cssquery-mootools.html) 12:26:25 INFO - PROCESS | 10880 | RSS: Main: 225636352 12:26:25 INFO - PROCESS | 10880 | 12:29:26 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43256/tests/dromaeo/cssquery-prototype.html) 12:29:27 INFO - PROCESS | 10880 | RSS: Main: 197660672 12:29:27 INFO - PROCESS | 10880 | 12:32:29 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43256/tests/dromaeo/cssquery-yui.html) 12:32:30 INFO - PROCESS | 10880 | RSS: Main: 195878912 12:32:30 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-yui.html (next: http://localhost:43256/tests/dromaeo/cssquery-dojo.html) 12:35:32 INFO - PROCESS | 10880 | RSS: Main: 240410624 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | __start_tp_report 12:35:32 INFO - PROCESS | 10880 | _x_x_mozilla_page_load 12:35:32 INFO - PROCESS | 10880 | _x_x_mozilla_page_load_details 12:35:32 INFO - PROCESS | 10880 | |i|pagename|runs| 12:35:32 INFO - PROCESS | 10880 | |0;dojo.html;3208.9518657220137;3263.41258573457;3279.688429599187;3283.704466598007;3306.0577735345432;5217.2695822584865;5232.7122008289525;5236.2931004314405;5242.921356179656;5247.370315562129;5256.08018596745;5271.4464981177;5285.445028272034;5295.947040529593;5333.306670132877;4655.976720116411;4849.903001939968;4900.215965445512;4936.7037977721275;4940.851774446773;4697.882552936187;4715.481297057321;4749.928751068736;4752.144613969484;4759.666823322369;4673.719576825384;4690.9530904690855;4709.411323584552;4718.787654555536;4723.031778485402;4796.616270698336;4814.8314808981695;4844.5882100021545;4862.367892173995;4885.975570122162;4795.832145874878;4810.7835147418455;4821.156297647933;4821.252705830602;4828.1068002419315;4953.281774142729;5017.046761115413;5046.1926091825135;5053.36832895888;5074.746262686888;5599.160125981095;5638.4361563843695;5639.379668236532;5643.181738647873;5649.0396632572565;5661.745221465003;5676.375598684142;5689.459501347365;5694.430556944314;5697.259356283698;5085.135526960388;5123.769430375642;5273.736313184364;5305.814296499642;5367.1680889462195;5728.226689396878;5780.653160810365;5788.507976822018;5789.131630255411;5790.276215473066;5540.14127810182;5573.637713548606;5577.972110139504;5581.358143813432;5581.916271255935;5391.7034563099405;5469.535089517356;5545.7781688732;5629.774809007594;5636.408177141423;5500.889982200333;5540.667559946416;5543.279373681396;5544.63959842617;5553.750081246354;5522.199281104217;5544.3346798384455;5556.333240011225;5557.777688892399;5578.358488773762;4170.854020109282;4205.642520385802;4257.1698518788535;4317.287647538184;4326.264535029052;3863.150106976461;3883.262180185812;3884.126071633916;3913.3738601824143;3913.6477717005605;5229.294045303835;5246.868828279324;5256.290400795843;5256.868578285574;5258.395284542326;5361.839144825662;5406.83779486616;5464.371597266286;5465.207544905967;5496.532794712494;5226.5818734501145;5263.815766448156;5276.947230527646;5279.1817268323475;5283.128283833124;4738.573528382393;4821.831235906727;4863.221884498464;4869.269609558594;4873;5588.776448941997;5638.323401191801;5671.489565939003;5701.344345400332;5734.139879018181;5606.607537472338;5608.270924779753;5610.831675049755;5612.7193640317;5619.49424551776;5564.054110801093;5665.886682266414;5759.136129580596;5759.740811663569;5765.4811067004175;5489.835304940858;5556.472135147316;5565.860853478695;5566.4990150886615;5595.608307418604;5535.7785688572;5628.85927851807;5630.943690563042;5635.8591035224445;5637.88724225505;5273.78904843802;5368.382635996911;5392.325959255093;5504.697241651747;5549;5453.10023846061;5453.836384908459;5454.400015998316;5460.945390546044;5465.562754979672;5332.09354409759;5339.759710812945;5373.650712703662;5389.434109418611;5411.729413529387;5333.813316533902;5349.090654588651;5465.398806131402;5492.80775172867;5553.194786755978;5352.143657014859;5357.812476563302;5388.595855310789;5393.217983392465;5402.864928376822 12:35:32 INFO - PROCESS | 10880 | |1;ext.html;564.3075476134493;595.568213045542;613.5398451161628;635.8156134720931;646.9611823290603;29431.85284073579;29966.550501742466;29971.85014074932;37867.810660946656;38335.61664383356;41225;41886;41934.16131677372;42030.36954445686;42083.368749468784;8672.739817805445;8808.867866982;8853.070427605106;8855;8866.556672166398;8888.777780555472;9082.318826088036;9082.86375704365;9083.591238394256;9086;9020.54897255138;9076.59155338008;9103.772405689844;9125.361224714272;9131.086891310882;8983.326250531203;9086.227670648002;9094.454332740057;9099.499527526017;9105.317101217435;8778.253848422892;8974.19232269099;8979.057198994076;8994.370394072417;8995.055519170459;42030.36954445686;42503.36244956328;42509.57490425087;42576.1484770306;42586.78706606478;3606.981965090184;3689.8524059037604;3702.962970370316;3816;4113.25961326961;32067.51898721521;32629.347413051604;32648;32756.344873102404;33281.66718332834;4321.978390108061;4333.155034768221;4406.1628290625;4408.713433626804;4418.536053714346;300112;300290;300980;301878;302094.48952755315;55212.44787552073;56085;61961.690191548754;62302;62357;63938.6803065991;65114.34885651083;65355.67322163359;65527.34472655308;65613.34386656072;15205.391784328724;15291.464798732213;15305.846941530664;15310.157941313335;15343.539693809204;12417.813732794015;12525.812112818316;12529.18560293578;12530.81203781944;12530.937345313398;20618;21254.574908501745;21266.149354025976;21305.25431609886;21307.68038479424;7427.888581671279;7515.098188217449;7581.886271705929;7610.086789585285;7642.19756925526;1065.3767545985531;1065.504540388723;1105.5135740274254;1142.9314241145391;1154.2596142890318;29498.55752163719;29512.409751804844;30582.847085764428;30760.38479230403;31080.22299442532;1144.3248483394837;1150.505282728418;1151.3264740126951;1160.0893298760432;1162.0645380468804;12824.487020519075;13218.60344189676;13315;13605;14634.41456843059;368356;372323;373060;373820;375955;55234.171487427724;55452.72273638606;55529;55547;55689.16466253009;1350.7366063617696;1359.7688392973218;1460.9561713148623;1480.9185494797673;1531.770234464817;26302.4739505205;26355.868220658773;26360;26637.866810666597;26702;41369.586304136574;41706.16587668169;41744.3738343919;41768;41796.58203417927;188198;189502;189797;189979;190278.04860975608;32474.35051299008;32842.67157328396;32886.67113328932;33248;33271;45502.089958201315;45561.54438455573;45770.542294576626;46471.53528464672;46545;37313.253734924605;37652.43521347237;37764.43353349647;38038;38968.41547376848;38119.80940095282;38310.61689383182;38631.80684096562;38800.22399552049;39147;38087.61912380841;38112.61887381202;38134.8093259543;38233.80883095678;38752;33342.66657333493;33976.83011584926;34489.827550862086;34687.82656086703;34829.477557836144;25997.350066248495;26141;26314.605280921183;26442.338941526617;26507.838232745355 12:35:32 INFO - PROCESS | 10880 | |2;jquery.html;382.29657430328206;384.12036436560277;384.353724606087;384.76144790230063;389.3400685837505;14221.075630084064;15336.923315383436;16442.91778541107;19365.322213722506;19372.612547749035;16542;16726.83273167268;17002.574935626617;17004.829951700478;17074;5997.850053748659;6189;6209.316975132731;6211.565190436671;6211.968940155293;4397.934030989538;4574.245249533823;4580.473245576768;4581.862544123682;6098.725557349908;6479;6525.445337146324;6728.360805723449;6740.292269311725;6769.966150169267;6444.194475690539;6481.351864813504;6569.901451478232;6572.934270657304;6587.868242635121;6567.376099270562;6576.276609572943;6577.473802095821;6580.506462015368;6592.538522303393;12574.43415046325;13153.934230328787;21807.127714891387;22770;22771.544569108526;2094.2251366994155;2169.8698078115362;2173.6413491773837;2184.803367696915;2196.2752291743686;9908.455034973074;10062.89937100627;10182.439965801877;10917.672469825919;13614.183149010993;1755;1849.630073985195;1962.9705554416696;1988.8210061094426;2006.067178761868;56209.71895140498;57137;57755.422445775424;58216;58771.41228587745;10996.835047474295;11021.779564408667;11047.171462140372;11056.391898445663;11112.722181945353;14283;14410.495632653017;14449.349779259748;14491.565253042425;14504.419823207165;7879.684812607432;7968.561729104839;8257.669693212325;8337.416380853281;8338.207870252316;8002.1997800219515;8053.476524025919;8073.354131669453;8105.8378832424205;8121.431499795076;4291.721038132574;4689.296605509201;4755.453122890843;4757.405324334458;4772.689775164603;1806.4580625812466;1835.476889086604;1952.0434986856337;1953.8143876331726;1979.7327360806396;919.6459363145237;973.8101070291225;980.2990861534038;999.6101520407047;1040.0639424517994;13632.386542605607;15800.604984875241;16958.830411695973;17078.23147958345;17240.913795431192;968.0851595242428;976.077606661712;1030.3714734012246;1072.2172813845937;1111.288775183883;9923.851142232872;10282.331648442827;10377.429241391645;10388.844167337496;10425.11386532138;538920;553681;566900;571001;573949;69696.30303697;69973.65013174902;72774.86649946844;78688.21311786924;82535.587322063;1183.0299154693241;1195.491915935724;1239.913206075566;1249.506444954238;1294.3592921503916;15715.292811823267;15761.211939402754;15832.28754706018;15873.444429444913;16388.672226555642;34157.65842341545;34222.82888585541;34528.48207276943;35402.29195416026;35508.82245588859;43328.56671433245;45476.54523454723;45959.3106103402;47947.5205247957;50512;7328.5969271690565;7586.468947173645;7733.845323093619;7876.527408355517;7912;9661.516924153624;11320.660380188607;11573.826392603949;11725;12128.575499857463;9773.511324433892;9870.309078364446;9945.651902183388;9989.250806189419;10343.793124137324;8757.649694012169;10248.128909042516;10509.527071281658;10513.842292365467;10650.041496265374;10266.230032747722;10438.582456701646;10584.8941510587;10667.51996160159;10873.401962892116;7943.96728425301;8039.758807235792;8106.148854370206;8123;8178.959105204436;8992.370534062815;10150.340227885164;10232.437215953194;10253.692389228336;10577.31247468912 12:35:32 INFO - PROCESS | 10880 | |3;mootools.html;1537.2544316006738;1557.8364271751466;1777.6000399910022;1837.8345948864599;1904.0574915416862;7749;7972.242636949495;7973.760787176379;7975.680972761097;7982.521048737072;7840;7877.8030549236155;7878.724244651438;7879.763607091796;7879.9212007879905;2371.4427109629223;2393.1863166523335;2402.771736685012;2407.422218667516;2409.6265078912797;2364.3213318543853;2393.9880300598475;2398.556267090585;2401.1235898896953;2401.267613377919;2008.0662491941243;2055.239561362298;2298.138198175684;2332.54515369503;2344.6834677318516;2326.581215381231;2338.0998315648512;2342.929712108631;2344.2146880794867;2352.929412117639;2275.2946586558055;2289.6107661697383;2305;2306.1006207579057;2306.815454763615;6869.210040845317;6998.545094568837;7269.636518174123;7375.151857536398;7378.815529611749;4686.554777296152;4777.116233496779;4785.521447855222;4793.832215872428;4803.423589169322;3176.8252746098956;3178.3484385700876;3215.469447541153;3226.6450690424035;3309.338132373535;1052.3896140238644;1052.9420881851572;1082.3289560472558;1088.2708585247904;1089.6186334782842;11058.11535077192;11060.115190784718;11060.668179954615;11112.666620001413;11137.276077054965;4482.21561226784;4523;4535.614472769786;4538.614217791524;4574.611158051536;9491.715248542554;9537.666181683608;9543.141117299476;9557.092076252884;9562.856557151648;4892.363992680928;4892.804287828447;4898.02039592083;4926.950730492721;4930.654854160174;4444.488883778342;4508.256137737302;4513.480949690762;4516.254817955067;4521.412216411911;3827.119762454651;3832.770033797981;3847.2882516734494;3864.574896761354;3868.1103346230525;1225.6935766058486;1235.604606525921;1243.055277988717;1247.5384107880143;1255.29076072019;1437.360374633278;1437.5687293812023;1440.2942558146642;1455.3523681961426;1458.4457905995866;7832.804179895548;7834.921650783534;7844.607769611611;7845.058592968766;7852.960735196401;535.6437968750815;540.0737734784863;549.0556243261584;549.4999550409109;551.1264645536869;5697.800576979786;5984.910226346608;6027.578069535178;6028.849278768066;6032.155498230251;8333.583290840572;9529;9717.319787614799;9823.803523929482;9826.263030272758;9435.386699864486;9581.425114493153;9658.517074146264;9675.951620241854;9987.450690211963;7720.15078341382;7870.606469676493;7880.84238315242;7881.172476889844;7887.645055972495;7680.385569154342;7770.611469426619;7778.494397864347;7794.727184548514;7846.960765196138;8763.07987661312;8792;8810.383273170817;8850.911490885266;8958.596863141043;8893.599788009426;9086.45481271126;9122.407043542149;9127.954360228156;9147;7280.325525129356;7343.082114735658;7345.3021962913435;7354.816129596589;7357.558546487228;7684.769456916301;7898.960505197438;7909.288164065261;7909.604519774103;7911.090224624242;7263.34629883313;7421.888671669822;7451.40388768908;7580;7708.498947568614;7374.373178279691;7411.666475008746;7470.0662417197855;7487.925120748723;7555;7507.662155203138;7528.058992625922;7582.696692132253;7598.430117741081;7619.885701714589;6907.7236910525025;6935.757248496278;6977;6987.056747339044;6990.965045174741;6947.583145011114;6990.2660220678135;6994.825129371807;7044.929550704427;7107 12:35:32 INFO - PROCESS | 10880 | |4;prototype.html;366.9688076513497;369.3849740182596;370.3722190886448;375.90038639760485;380.9790461524615;5999.940000599992;6071.848203794902;6115.480184184344;6120.357362476942;6139.969300153504;6047.15339852421;6059.242594675666;6062.302835173957;6062.8484287892825;6071.908921366183;4537.478190008142;4659.347691323217;4661.813527458915;4666.789994450241;4749.216379297412;4705.764711764416;4706.176419126657;4707.6233901287815;4714.834980775673;4719.174144524694;4441.267190913495;4576.725396476222;4680.5085466026085;4686.531346865303;4692.741899195543;4537.523560026199;4566.6575006874455;4602.907941841145;4613.930791038137;4641.419822522184;4018.537868145142;4045.37296719009;4057.2088442753675;4067.837286508536;4069.776162311072;5585.134304182858;5710.457506536873;5801.3328467225965;5804.564657650651;5815.941840581625;5291.656042357235;5292.126799078147;5433.701146436944;5436.972815135899;5446.21029950655;6344.524160687967;6357.364263573606;6362.872742545123;6366.649834259114;6367.554271201017;4581.129585378767;4581.977090114561;4582.404287442644;4584.174848527264;4590.885227869297;6439.484841212692;6668.699908504129;6677.298883617199;6677.666116694194;6684.131062961833;4553.043860789205;4556.498785133699;4556.567126123013;4562.178807814559;4565.178267911808;4611.2852507861335;4613.8846528836375;4617.676762626651;4618.35343051973;4628.514006029386;5232.2674825524455;5309.964556911365;5328.120860058125;5337.8131765388025;5338.706371149547;6372.6495042773095;6431.5819471734185;6438.484921206292;6440;6447.1296374989715;1651.2321770376832;1672.2140593920838;1672.7992640883172;1672.9079900605584;1674.1712852138269;1136.4772204785727;1139.1911742662803;1143.0798207442922;1146.5471138900089;1173.3136115372602;6130.049842274455;6139.048447490646;6144.047672610753;6145.231846019247;6145.754169833246;6607.339266073354;6614.8346291343105;6622.63575503352;6626.503012274003;6630.436412904861;6025.758969641253;6147.723352449061;6150.538709596798;6151.569390142647;6159.076138579249;3539.8938031859084;3577.58857731359;3580.1765593913024;3580.695640870503;3582.0865679252147;6797.830054248683;6798.184217893786;6799.150106236721;6806.217285012188;6807.149106361705;6490.286068532458;6513.348665133543;6640.0703901453835;6694.397504224643;6744.426723728538;6796.388325050769;6845.863082738417;6859.382655561023;6875.931240687629;6879.071325371011;6655.667216639052;6657.400833924777;6665.566738162004;6666.666666666744;6670.166229221348;6408.871822563616;6555.541112122106;6564.868702625825;6566.409023187936;6566.8358291041195;6845.418139458003;6857.5199736018;6859.416949559144;6859.794206173623;6860.759873404407;4706.411698537683;4709.17589421843;4716.575508204278;4717.457492388419;4721.6071258978;6540.149780528501;6683.264840867598;6683.933160668331;6686.899696504654;6690.698918548775;6511.641859697762;6513.7068831903625;6524.934750652433;6527.249366322933;6528.020796880506;6508.739650413931;6514.185726784152;6515.250746164252;6583.078369028436;6588.670566471753;6182.103594978613;6364.427201551883;6381.234251889803;6395.296517382991;6403.455706265019;6516.283208846929;6527.836804079936;6536.673166341759;6536.803895883131;6541.574797638138;6332.810015699536;6364.968175159094;6379.712912918837;6381.3937675920715;6387.297397286387 12:35:32 INFO - PROCESS | 10880 | |5;yui.html;763.3664058831171;776.8795836645322;866.5017614871449;914.9405288656233;948.1892981500816;14545.854541454595;14683.632909177277;14717.92641036796;14719.043262187965;14719.632009199748;13842.584722458318;13910.026298159133;13911.582652520441;15084.773728394055;15444.845551544482;732.1287667675449;905.3391024552097;915.697819719491;915.9404638698496;917.0325306801321;750.5571712689513;750.9849803003937;752.5898385379982;900.4732231644496;918.9264858811279;943;947.8625599288099;951.1202138022336;951.4386511957944;951.5432592355673;944.919681827042;949.6960972488806;954.374884450686;956.3687965942514;956.9617215311379;576.2479963647438;582.676614478964;582.7785441532233;584.0771580902165;685.2838783471235;15045.322960466805;15047.623809404853;15070.773938390932;15125.16811575363;15243.314050867737;13537.796933046013;13684.452621895112;14026.859731402657;14067.859321406757;14068.507602233974;11576.594819181373;11641.767164656743;11681.299122052618;11729.354885481294;12027.338496382696;3800;3822.7515211511163;3827.2536855313224;3859.671927886133;3865.768053916774;53659.19511207335;53937;54852.45147548553;54943.725281373736;54955;10654.73363165927;11036.889631103746;11139.610113645984;11253.930876566714;11288.503946436253;19417.902910485358;19492.805071949384;19505.414837554898;19527.218911243675;19556.90221548883;7800.063992320957;7880.724174653859;7899.328557072598;8037.23646253605;8080.191980801873;4516.8644940651175;4566.589006989387;4572.291294849304;4579.656525760514;4592.839250626212;3233.1593785615437;3270.9182270442952;3272.476403775432;3274.2305558193807;3274.476083826624;562.9493345598834;571.451406649621;572.6335145506879;578.0721941284178;579.828950459607;595.0687174571781;730.4448619049455;753.7587971849065;770.7821641805933;770.9537427754352;8742.606582703793;9507.809843803223;9861.901380986099;9913.65302214419;9922.107010369102;539.3904887477125;632.0868277266201;761.9923800762032;764.81262090787;782.2334112569714;4260.595243451867;4450.888727781831;4479.910401791946;4480.775961201927;4543.636509079266;61275.38724612786;62166;62477.687611562564;62913.37086629167;62965;50799.492005079475;52010.219846702326;52616.21075683868;52721.47278527165;52824.73587632114;48753.75623121862;51489.742551287;51523.742381288605;52082.739586301825;52195.73902130465;9612.279079068958;9624.133827955518;9649.276304277068;9674.935757066858;9724.31929764938;36811.07972300714;37230.627693722716;37585.49658013758;38286.23427531489;39549;49320.75339623279;49784.751076244385;50216.49783502118;50345.244821326974;50362.055398958626;12408.255504669749;13281.734365312834;13312.467501300227;13359.799603005767;13432.597022089352;13194.340282986004;13712.725745484835;13889.236092015037;14348.354324055652;14381.640458988191;12813.551525696928;12828;13009.7580657212;13187.406566704713;13509.392077356739;13010.544630937871;13131.671708207372;13148.474061037452;13258.270795105977;13433.66415839612;10561;12290.81563776562;12371.628851134481;12413.193142445713;12487.875121249035;9919.801603968024;9990.750231244278;9993.950030249802;10091.646792362231;10356.171506279328;10311.845322320321;10559;10817.56729730802;10824.079953204066;10881.673549793519 12:35:32 INFO - PROCESS | 10880 | __end_tp_report 12:35:32 INFO - PROCESS | 10880 | __start_cc_report 12:35:32 INFO - PROCESS | 10880 | _x_x_mozilla_cycle_collect,844 12:35:32 INFO - PROCESS | 10880 | __end_cc_report 12:35:32 INFO - PROCESS | 10880 | __startTimestamp1457728532985__endTimestamp 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | ------- Summary: start ------- 12:35:32 INFO - PROCESS | 10880 | Number of tests: 6 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#0] dojo.html Cycles:165 Average:5195.07 Median:5367.17 stddev:549.88 (10.2%) stddev-sans-first:529.04 12:35:32 INFO - PROCESS | 10880 | Values: 3209.0 3263.4 3279.7 3283.7 3306.1 5217.3 5232.7 5236.3 5242.9 5247.4 5256.1 5271.4 5285.4 5295.9 5333.3 4656.0 4849.9 4900.2 4936.7 4940.9 4697.9 4715.5 4749.9 4752.1 4759.7 4673.7 4691.0 4709.4 4718.8 4723.0 4796.6 4814.8 4844.6 4862.4 4886.0 4795.8 4810.8 4821.2 4821.3 4828.1 4953.3 5017.0 5046.2 5053.4 5074.7 5599.2 5638.4 5639.4 5643.2 5649.0 5661.7 5676.4 5689.5 5694.4 5697.3 5085.1 5123.8 5273.7 5305.8 5367.2 5728.2 5780.7 5788.5 5789.1 5790.3 5540.1 5573.6 5578.0 5581.4 5581.9 5391.7 5469.5 5545.8 5629.8 5636.4 5500.9 5540.7 5543.3 5544.6 5553.8 5522.2 5544.3 5556.3 5557.8 5578.4 4170.9 4205.6 4257.2 4317.3 4326.3 3863.2 3883.3 3884.1 3913.4 3913.6 5229.3 5246.9 5256.3 5256.9 5258.4 5361.8 5406.8 5464.4 5465.2 5496.5 5226.6 5263.8 5276.9 5279.2 5283.1 4738.6 4821.8 4863.2 4869.3 4873.0 5588.8 5638.3 5671.5 5701.3 5734.1 5606.6 5608.3 5610.8 5612.7 5619.5 5564.1 5665.9 5759.1 5759.7 5765.5 5489.8 5556.5 5565.9 5566.5 5595.6 5535.8 5628.9 5630.9 5635.9 5637.9 5273.8 5368.4 5392.3 5504.7 5549.0 5453.1 5453.8 5454.4 5460.9 5465.6 5332.1 5339.8 5373.7 5389.4 5411.7 5333.8 5349.1 5465.4 5492.8 5553.2 5352.1 5357.8 5388.6 5393.2 5402.9 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#1] ext.html Cycles:180 Average:46492.86 Median:38062.81 stddev:78145.03 (205.3%) stddev-sans-first:78288.16 12:35:32 INFO - PROCESS | 10880 | Values: 564.3 595.6 613.5 635.8 647.0 29431.9 29966.6 29971.9 37867.8 38335.6 41225.0 41886.0 41934.2 42030.4 42083.4 8672.7 8808.9 8853.1 8855.0 8866.6 8888.8 9082.3 9082.9 9083.6 9086.0 9020.5 9076.6 9103.8 9125.4 9131.1 8983.3 9086.2 9094.5 9099.5 9105.3 8778.3 8974.2 8979.1 8994.4 8995.1 42030.4 42503.4 42509.6 42576.1 42586.8 3607.0 3689.9 3703.0 3816.0 4113.3 32067.5 32629.3 32648.0 32756.3 33281.7 4322.0 4333.2 4406.2 4408.7 4418.5 300112.0 300290.0 300980.0 301878.0 302094.5 55212.4 56085.0 61961.7 62302.0 62357.0 63938.7 65114.3 65355.7 65527.3 65613.3 15205.4 15291.5 15305.8 15310.2 15343.5 12417.8 12525.8 12529.2 12530.8 12530.9 20618.0 21254.6 21266.1 21305.3 21307.7 7427.9 7515.1 7581.9 7610.1 7642.2 1065.4 1065.5 1105.5 1142.9 1154.3 29498.6 29512.4 30582.8 30760.4 31080.2 1144.3 1150.5 1151.3 1160.1 1162.1 12824.5 13218.6 13315.0 13605.0 14634.4 368356.0 372323.0 373060.0 373820.0 375955.0 55234.2 55452.7 55529.0 55547.0 55689.2 1350.7 1359.8 1461.0 1480.9 1531.8 26302.5 26355.9 26360.0 26637.9 26702.0 41369.6 41706.2 41744.4 41768.0 41796.6 188198.0 189502.0 189797.0 189979.0 190278.0 32474.4 32842.7 32886.7 33248.0 33271.0 45502.1 45561.5 45770.5 46471.5 46545.0 37313.3 37652.4 37764.4 38038.0 38968.4 38119.8 38310.6 38631.8 38800.2 39147.0 38087.6 38112.6 38134.8 38233.8 38752.0 33342.7 33976.8 34489.8 34687.8 34829.5 25997.4 26141.0 26314.6 26442.3 26507.8 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#2] jquery.html Cycles:180 Average:28746.41 Median:383.21 stddev:91600.77 (23903.6%) stddev-sans-first:91832.97 12:35:32 INFO - PROCESS | 10880 | Values: 382.3 384.1 384.4 384.8 389.3 14221.1 15336.9 16442.9 19365.3 19372.6 16542.0 16726.8 17002.6 17004.8 17074.0 5997.9 6189.0 6209.3 6211.6 6212.0 4397.9 4574.2 4580.5 4581.9 6098.7 6479.0 6525.4 6728.4 6740.3 6770.0 6444.2 6481.4 6569.9 6572.9 6587.9 6567.4 6576.3 6577.5 6580.5 6592.5 12574.4 13153.9 21807.1 22770.0 22771.5 2094.2 2169.9 2173.6 2184.8 2196.3 9908.5 10062.9 10182.4 10917.7 13614.2 1755.0 1849.6 1963.0 1988.8 2006.1 56209.7 57137.0 57755.4 58216.0 58771.4 10996.8 11021.8 11047.2 11056.4 11112.7 14283.0 14410.5 14449.3 14491.6 14504.4 7879.7 7968.6 8257.7 8337.4 8338.2 8002.2 8053.5 8073.4 8105.8 8121.4 4291.7 4689.3 4755.5 4757.4 4772.7 1806.5 1835.5 1952.0 1953.8 1979.7 919.6 973.8 980.3 999.6 1040.1 13632.4 15800.6 16958.8 17078.2 17240.9 968.1 976.1 1030.4 1072.2 1111.3 9923.9 10282.3 10377.4 10388.8 10425.1 538920.0 553681.0 566900.0 571001.0 573949.0 69696.3 69973.7 72774.9 78688.2 82535.6 1183.0 1195.5 1239.9 1249.5 1294.4 15715.3 15761.2 15832.3 15873.4 16388.7 34157.7 34222.8 34528.5 35402.3 35508.8 43328.6 45476.5 45959.3 47947.5 50512.0 7328.6 7586.5 7733.8 7876.5 7912.0 9661.5 11320.7 11573.8 11725.0 12128.6 9773.5 9870.3 9945.7 9989.3 10343.8 8757.6 10248.1 10509.5 10513.8 10650.0 10266.2 10438.6 10584.9 10667.5 10873.4 7944.0 8039.8 8106.1 8123.0 8179.0 8992.4 10150.3 10232.4 10253.7 10577.3 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#3] mootools.html Cycles:180 Average:5699.33 Median:6888.47 stddev:2960.31 (43.0%) stddev-sans-first:2952.08 12:35:32 INFO - PROCESS | 10880 | Values: 1537.3 1557.8 1777.6 1837.8 1904.1 7749.0 7972.2 7973.8 7975.7 7982.5 7840.0 7877.8 7878.7 7879.8 7879.9 2371.4 2393.2 2402.8 2407.4 2409.6 2364.3 2394.0 2398.6 2401.1 2401.3 2008.1 2055.2 2298.1 2332.5 2344.7 2326.6 2338.1 2342.9 2344.2 2352.9 2275.3 2289.6 2305.0 2306.1 2306.8 6869.2 6998.5 7269.6 7375.2 7378.8 4686.6 4777.1 4785.5 4793.8 4803.4 3176.8 3178.3 3215.5 3226.6 3309.3 1052.4 1052.9 1082.3 1088.3 1089.6 11058.1 11060.1 11060.7 11112.7 11137.3 4482.2 4523.0 4535.6 4538.6 4574.6 9491.7 9537.7 9543.1 9557.1 9562.9 4892.4 4892.8 4898.0 4927.0 4930.7 4444.5 4508.3 4513.5 4516.3 4521.4 3827.1 3832.8 3847.3 3864.6 3868.1 1225.7 1235.6 1243.1 1247.5 1255.3 1437.4 1437.6 1440.3 1455.4 1458.4 7832.8 7834.9 7844.6 7845.1 7853.0 535.6 540.1 549.1 549.5 551.1 5697.8 5984.9 6027.6 6028.8 6032.2 8333.6 9529.0 9717.3 9823.8 9826.3 9435.4 9581.4 9658.5 9676.0 9987.5 7720.2 7870.6 7880.8 7881.2 7887.6 7680.4 7770.6 7778.5 7794.7 7847.0 8763.1 8792.0 8810.4 8850.9 8958.6 8893.6 9086.5 9122.4 9128.0 9147.0 7280.3 7343.1 7345.3 7354.8 7357.6 7684.8 7899.0 7909.3 7909.6 7911.1 7263.3 7421.9 7451.4 7580.0 7708.5 7374.4 7411.7 7470.1 7487.9 7555.0 7507.7 7528.1 7582.7 7598.4 7619.9 6907.7 6935.8 6977.0 6987.1 6991.0 6947.6 6990.3 6994.8 7044.9 7107.0 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#4] prototype.html Cycles:180 Average:5389.90 Median:6134.55 stddev:1604.42 (26.2%) stddev-sans-first:1564.00 12:35:32 INFO - PROCESS | 10880 | Values: 367.0 369.4 370.4 375.9 381.0 5999.9 6071.8 6115.5 6120.4 6140.0 6047.2 6059.2 6062.3 6062.8 6071.9 4537.5 4659.3 4661.8 4666.8 4749.2 4705.8 4706.2 4707.6 4714.8 4719.2 4441.3 4576.7 4680.5 4686.5 4692.7 4537.5 4566.7 4602.9 4613.9 4641.4 4018.5 4045.4 4057.2 4067.8 4069.8 5585.1 5710.5 5801.3 5804.6 5815.9 5291.7 5292.1 5433.7 5437.0 5446.2 6344.5 6357.4 6362.9 6366.6 6367.6 4581.1 4582.0 4582.4 4584.2 4590.9 6439.5 6668.7 6677.3 6677.7 6684.1 4553.0 4556.5 4556.6 4562.2 4565.2 4611.3 4613.9 4617.7 4618.4 4628.5 5232.3 5310.0 5328.1 5337.8 5338.7 6372.6 6431.6 6438.5 6440.0 6447.1 1651.2 1672.2 1672.8 1672.9 1674.2 1136.5 1139.2 1143.1 1146.5 1173.3 6130.0 6139.0 6144.0 6145.2 6145.8 6607.3 6614.8 6622.6 6626.5 6630.4 6025.8 6147.7 6150.5 6151.6 6159.1 3539.9 3577.6 3580.2 3580.7 3582.1 6797.8 6798.2 6799.2 6806.2 6807.1 6490.3 6513.3 6640.1 6694.4 6744.4 6796.4 6845.9 6859.4 6875.9 6879.1 6655.7 6657.4 6665.6 6666.7 6670.2 6408.9 6555.5 6564.9 6566.4 6566.8 6845.4 6857.5 6859.4 6859.8 6860.8 4706.4 4709.2 4716.6 4717.5 4721.6 6540.1 6683.3 6683.9 6686.9 6690.7 6511.6 6513.7 6524.9 6527.2 6528.0 6508.7 6514.2 6515.3 6583.1 6588.7 6182.1 6364.4 6381.2 6395.3 6403.5 6516.3 6527.8 6536.7 6536.8 6541.6 6332.8 6365.0 6379.7 6381.4 6387.3 12:35:32 INFO - PROCESS | 10880 | 12:35:32 INFO - PROCESS | 10880 | [#5] yui.html Cycles:180 Average:15138.30 Median:4586.25 stddev:17345.54 (378.2%) stddev-sans-first:17360.61 12:35:32 INFO - PROCESS | 10880 | Values: 763.4 776.9 866.5 914.9 948.2 14545.9 14683.6 14717.9 14719.0 14719.6 13842.6 13910.0 13911.6 15084.8 15444.8 732.1 905.3 915.7 915.9 917.0 750.6 751.0 752.6 900.5 918.9 943.0 947.9 951.1 951.4 951.5 944.9 949.7 954.4 956.4 957.0 576.2 582.7 582.8 584.1 685.3 15045.3 15047.6 15070.8 15125.2 15243.3 13537.8 13684.5 14026.9 14067.9 14068.5 11576.6 11641.8 11681.3 11729.4 12027.3 3800.0 3822.8 3827.3 3859.7 3865.8 53659.2 53937.0 54852.5 54943.7 54955.0 10654.7 11036.9 11139.6 11253.9 11288.5 19417.9 19492.8 19505.4 19527.2 19556.9 7800.1 7880.7 7899.3 8037.2 8080.2 4516.9 4566.6 4572.3 4579.7 4592.8 3233.2 3270.9 3272.5 3274.2 3274.5 562.9 571.5 572.6 578.1 579.8 595.1 730.4 753.8 770.8 771.0 8742.6 9507.8 9861.9 9913.7 9922.1 539.4 632.1 762.0 764.8 782.2 4260.6 4450.9 4479.9 4480.8 4543.6 61275.4 62166.0 62477.7 62913.4 62965.0 50799.5 52010.2 52616.2 52721.5 52824.7 48753.8 51489.7 51523.7 52082.7 52195.7 9612.3 9624.1 9649.3 9674.9 9724.3 36811.1 37230.6 37585.5 38286.2 39549.0 49320.8 49784.8 50216.5 50345.2 50362.1 12408.3 13281.7 13312.5 13359.8 13432.6 13194.3 13712.7 13889.2 14348.4 14381.6 12813.6 12828.0 13009.8 13187.4 13509.4 13010.5 13131.7 13148.5 13258.3 13433.7 10561.0 12290.8 12371.6 12413.2 12487.9 9919.8 9990.8 9994.0 10091.6 10356.2 10311.8 10559.0 10817.6 10824.1 10881.7 12:35:32 INFO - PROCESS | 10880 | -------- Summary: end -------- 12:35:32 INFO - PROCESS | 10880 | 12:35:33 INFO - TEST-INFO | 10880: exit 0 12:35:33 INFO - TEST-OK | dromaeo_css | took 1110247ms 12:35:33 INFO - TEST-START | kraken 12:35:33 INFO - operating with platform_type : linux_ 12:35:33 INFO - Initialising browser for kraken test... 12:35:33 INFO - TEST-INFO | started process 11069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGEyzV/profile http://localhost:43256/getInfo.html) 12:35:37 INFO - PROCESS | 11069 | __metrics Screen width/height:1600/1200 12:35:37 INFO - PROCESS | 11069 | colorDepth:24 12:35:37 INFO - PROCESS | 11069 | Browser inner width/height: 1024/697 12:35:37 INFO - PROCESS | 11069 | __metrics 12:35:37 INFO - PROCESS | 11069 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:38 INFO - TEST-INFO | 11069: exit 0 12:35:38 INFO - Browser initialized. 12:35:38 INFO - Running cycle 1/1 for kraken test... 12:35:38 INFO - TEST-INFO | started process 11163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGEyzV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:50 INFO - PROCESS | 11163 | RSS: Main: 136380416 12:35:50 INFO - PROCESS | 11163 | 12:35:52 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:53 INFO - PROCESS | 11163 | RSS: Main: 171151360 12:35:53 INFO - PROCESS | 11163 | 12:35:56 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-dft) 12:35:56 INFO - PROCESS | 11163 | RSS: Main: 169619456 12:35:56 INFO - PROCESS | 11163 | 12:35:59 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-fft) 12:35:59 INFO - PROCESS | 11163 | RSS: Main: 166555648 12:35:59 INFO - PROCESS | 11163 | 12:36:01 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator) 12:36:02 INFO - PROCESS | 11163 | RSS: Main: 165638144 12:36:02 INFO - PROCESS | 11163 | 12:36:04 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:05 INFO - PROCESS | 11163 | RSS: Main: 165101568 12:36:05 INFO - PROCESS | 11163 | 12:36:08 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:08 INFO - PROCESS | 11163 | RSS: Main: 164524032 12:36:08 INFO - PROCESS | 11163 | 12:36:11 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:12 INFO - PROCESS | 11163 | RSS: Main: 166146048 12:36:12 INFO - PROCESS | 11163 | 12:36:15 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial) 12:36:15 INFO - PROCESS | 11163 | RSS: Main: 166359040 12:36:15 INFO - PROCESS | 11163 | 12:36:17 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:17 INFO - PROCESS | 11163 | RSS: Main: 169377792 12:36:17 INFO - PROCESS | 11163 | 12:36:19 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:20 INFO - PROCESS | 11163 | RSS: Main: 167034880 12:36:20 INFO - PROCESS | 11163 | 12:36:22 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:22 INFO - PROCESS | 11163 | RSS: Main: 171143168 12:36:22 INFO - PROCESS | 11163 | 12:36:25 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:25 INFO - PROCESS | 11163 | RSS: Main: 174682112 12:36:25 INFO - PROCESS | 11163 | 12:36:28 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:28 INFO - PROCESS | 11163 | RSS: Main: 172904448 12:36:28 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43256/tests/kraken/driver.html?testName=ai-astar) 12:36:30 INFO - PROCESS | 11163 | RSS: Main: 232562688 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | __start_tp_report 12:36:30 INFO - PROCESS | 11163 | _x_x_mozilla_page_load 12:36:30 INFO - PROCESS | 11163 | _x_x_mozilla_page_load_details 12:36:30 INFO - PROCESS | 11163 | |i|pagename|runs| 12:36:30 INFO - PROCESS | 11163 | |0;ai-astar;109;110;106;109;109;110;101;111;110;109 12:36:30 INFO - PROCESS | 11163 | |1;audio-beat-detection;151;123;156;159;123;151;153;131;163;126 12:36:30 INFO - PROCESS | 11163 | |2;audio-dft;160;161;161;161;161;160;158;164;160;161 12:36:30 INFO - PROCESS | 11163 | |3;audio-fft;73;76;73;148;74;74;73;75;146;72 12:36:30 INFO - PROCESS | 11163 | |4;audio-oscillator;95;96;140;94;95;95;138;95;96;132 12:36:30 INFO - PROCESS | 11163 | |5;imaging-gaussian-blur;110;109;109;110;109;109;110;108;109;109 12:36:30 INFO - PROCESS | 11163 | |6;imaging-darkroom;147;146;147;147;146;148;147;145;146;146 12:36:30 INFO - PROCESS | 11163 | |7;imaging-desaturate;96;96;95;96;95;96;96;96;97;96 12:36:30 INFO - PROCESS | 11163 | |8;json-parse-financial;54;55;55;54;54;54;57;55;52;53 12:36:30 INFO - PROCESS | 11163 | |9;json-stringify-tinderbox;64;64;64;65;66;65;64;64;65;64 12:36:30 INFO - PROCESS | 11163 | |10;stanford-crypto-aes;77;80;81;79;79;79;78;79;81;85 12:36:30 INFO - PROCESS | 11163 | |11;stanford-crypto-ccm;111;116;111;115;110;118;108;111;116;112 12:36:30 INFO - PROCESS | 11163 | |12;stanford-crypto-pbkdf2;137;143;137;135;135;135;137;135;134;146 12:36:30 INFO - PROCESS | 11163 | |13;stanford-crypto-sha256-iterative;64;66;66;64;64;65;65;64;64;63 12:36:30 INFO - PROCESS | 11163 | __end_tp_report 12:36:30 INFO - PROCESS | 11163 | __start_cc_report 12:36:30 INFO - PROCESS | 11163 | _x_x_mozilla_cycle_collect,913 12:36:30 INFO - PROCESS | 11163 | __end_cc_report 12:36:30 INFO - PROCESS | 11163 | __startTimestamp1457728590745__endTimestamp 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | ------- Summary: start ------- 12:36:30 INFO - PROCESS | 11163 | Number of tests: 14 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:2.91 (2.7%) stddev-sans-first:3.08 12:36:30 INFO - PROCESS | 11163 | Values: 109.0 110.0 106.0 109.0 109.0 110.0 101.0 111.0 110.0 109.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:152.00 stddev:15.92 (10.5%) stddev-sans-first:16.66 12:36:30 INFO - PROCESS | 11163 | Values: 151.0 123.0 156.0 159.0 123.0 151.0 153.0 131.0 163.0 126.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 12:36:30 INFO - PROCESS | 11163 | Values: 160.0 161.0 161.0 161.0 161.0 160.0 158.0 164.0 160.0 161.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#3] audio-fft Cycles:10 Average:88.40 Median:73.50 stddev:30.91 (42.1%) stddev-sans-first:32.28 12:36:30 INFO - PROCESS | 11163 | Values: 73.0 76.0 73.0 148.0 74.0 74.0 73.0 75.0 146.0 72.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:95.00 stddev:20.16 (21.2%) stddev-sans-first:20.86 12:36:30 INFO - PROCESS | 11163 | Values: 95.0 96.0 140.0 94.0 95.0 95.0 138.0 95.0 96.0 132.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 12:36:30 INFO - PROCESS | 11163 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 110.0 108.0 109.0 109.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 12:36:30 INFO - PROCESS | 11163 | Values: 147.0 146.0 147.0 147.0 146.0 148.0 147.0 145.0 146.0 146.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:36:30 INFO - PROCESS | 11163 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.34 (2.5%) stddev-sans-first:1.41 12:36:30 INFO - PROCESS | 11163 | Values: 54.0 55.0 55.0 54.0 54.0 54.0 57.0 55.0 52.0 53.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:36:30 INFO - PROCESS | 11163 | Values: 64.0 64.0 64.0 65.0 66.0 65.0 64.0 64.0 65.0 64.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:2.20 (2.8%) stddev-sans-first:2.09 12:36:30 INFO - PROCESS | 11163 | Values: 77.0 80.0 81.0 79.0 79.0 79.0 78.0 79.0 81.0 85.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:113.50 stddev:3.22 (2.8%) stddev-sans-first:3.35 12:36:30 INFO - PROCESS | 11163 | Values: 111.0 116.0 111.0 115.0 110.0 118.0 108.0 111.0 116.0 112.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.40 Median:137.00 stddev:3.95 (2.9%) stddev-sans-first:4.19 12:36:30 INFO - PROCESS | 11163 | Values: 137.0 143.0 137.0 135.0 135.0 135.0 137.0 135.0 134.0 146.0 12:36:30 INFO - PROCESS | 11163 | 12:36:30 INFO - PROCESS | 11163 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 12:36:30 INFO - PROCESS | 11163 | Values: 64.0 66.0 66.0 64.0 64.0 65.0 65.0 64.0 64.0 63.0 12:36:30 INFO - PROCESS | 11163 | -------- Summary: end -------- 12:36:30 INFO - PROCESS | 11163 | 12:36:31 INFO - TEST-INFO | 11163: exit 0 12:36:31 INFO - TEST-OK | kraken | took 57989ms 12:36:31 INFO - TEST-START | v8_7 12:36:31 INFO - operating with platform_type : linux_ 12:36:31 INFO - Initialising browser for v8_7 test... 12:36:31 INFO - TEST-INFO | started process 11417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtYXoV/profile http://localhost:43256/getInfo.html) 12:36:35 INFO - PROCESS | 11417 | __metrics Screen width/height:1600/1200 12:36:35 INFO - PROCESS | 11417 | colorDepth:24 12:36:35 INFO - PROCESS | 11417 | Browser inner width/height: 1024/697 12:36:35 INFO - PROCESS | 11417 | __metrics 12:36:35 INFO - PROCESS | 11417 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:36 INFO - TEST-INFO | 11417: exit 0 12:36:36 INFO - Browser initialized. 12:36:36 INFO - Running cycle 1/1 for v8_7 test... 12:36:36 INFO - TEST-INFO | started process 11503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtYXoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:48 INFO - PROCESS | 11503 | RSS: Main: 135344128 12:36:48 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | Cycle 1(1): loaded http://localhost:43256/tests/v8_7/run.html (next: http://localhost:43256/tests/v8_7/run.html) 12:37:10 INFO - PROCESS | 11503 | RSS: Main: 424148992 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | __start_tp_report 12:37:10 INFO - PROCESS | 11503 | _x_x_mozilla_page_load 12:37:10 INFO - PROCESS | 11503 | _x_x_mozilla_page_load_details 12:37:10 INFO - PROCESS | 11503 | |i|pagename|runs| 12:37:10 INFO - PROCESS | 11503 | |0;Richards;165.8374792703151 12:37:10 INFO - PROCESS | 11503 | |1;DeltaBlue;175.28483786152498 12:37:10 INFO - PROCESS | 11503 | |2;Encrypt;277.700638711469 12:37:10 INFO - PROCESS | 11503 | |3;Decrypt;5246.073298429319 12:37:10 INFO - PROCESS | 11503 | |4;RayTrace;972.7626459143969 12:37:10 INFO - PROCESS | 11503 | |5;Earley;554.9389567147614 12:37:10 INFO - PROCESS | 11503 | |6;Boyer;10763.440860215054 12:37:10 INFO - PROCESS | 11503 | |7;RegExp;40400 12:37:10 INFO - PROCESS | 11503 | |8;Splay;519.4805194805194 12:37:10 INFO - PROCESS | 11503 | |9;NavierStokes;4830.917874396136 12:37:10 INFO - PROCESS | 11503 | __end_tp_report 12:37:10 INFO - PROCESS | 11503 | __startTimestamp1457728630929__endTimestamp 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | ------- Summary: start ------- 12:37:10 INFO - PROCESS | 11503 | Number of tests: 10 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#0] Richards Cycles:1 Average:165.84 Median:165.84 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 165.8 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#1] DeltaBlue Cycles:1 Average:175.28 Median:175.28 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 175.3 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 277.7 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 5246.1 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#4] RayTrace Cycles:1 Average:972.76 Median:972.76 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 972.8 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#5] Earley Cycles:1 Average:554.94 Median:554.94 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 554.9 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#6] Boyer Cycles:1 Average:10763.44 Median:10763.44 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 10763.4 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#7] RegExp Cycles:1 Average:40400.00 Median:40400.00 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 40400.0 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#8] Splay Cycles:1 Average:519.48 Median:519.48 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 519.5 12:37:10 INFO - PROCESS | 11503 | 12:37:10 INFO - PROCESS | 11503 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:37:10 INFO - PROCESS | 11503 | Values: 4830.9 12:37:10 INFO - PROCESS | 11503 | -------- Summary: end -------- 12:37:10 INFO - PROCESS | 11503 | 12:37:11 INFO - TEST-INFO | 11503: exit 0 12:37:11 INFO - TEST-OK | v8_7 | took 40125ms 12:37:11 INFO - SUITE-END | took 1208s 12:37:11 INFO - Completed test suite (00:20:08) 12:37:11 INFO - Working with test: dromaeo_css 12:37:11 INFO - Generating results file: dromaeo_css 12:37:11 INFO - Working with test: kraken 12:37:11 INFO - Generating results file: kraken 12:37:11 INFO - javascript benchmark 12:37:11 INFO - Working with test: v8_7 12:37:11 INFO - Generating results file: v8_7 12:37:11 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 12:37:12 INFO - process_Request line: dromaeo_css 7140.60 graph.html#tests=[[72,181,35]] 12:37:12 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:12 INFO - process_Request line: kraken 1473.60 graph.html#tests=[[232,181,35]] 12:37:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:12 INFO - process_Request line: v8_7 21895.32 graph.html#tests=[[230,181,35]] 12:37:12 INFO - RETURN: dromaeo_css: 7140.60 12:37:12 INFO - RETURN: kraken: 1473.60 12:37:12 INFO - RETURN: v8_7: 21895.32 12:37:12 INFO - javascript benchmark 12:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3208.9518657220137, 3263.41258573457, 3279.688429599187, 3283.704466598007, 3306.0577735345432, 5217.2695822584865, 5232.7122008289525, 5236.2931004314405, 5242.921356179656, 5247.370315562129, 5256.08018596745, 5271.4464981177, 5285.445028272034, 5295.947040529593, 5333.306670132877, 4655.976720116411, 4849.903001939968, 4900.215965445512, 4936.7037977721275, 4940.851774446773, 4697.882552936187, 4715.481297057321, 4749.928751068736, 4752.144613969484, 4759.666823322369, 4673.719576825384, 4690.9530904690855, 4709.411323584552, 4718.787654555536, 4723.031778485402, 4796.616270698336, 4814.8314808981695, 4844.5882100021545, 4862.367892173995, 4885.975570122162, 4795.832145874878, 4810.7835147418455, 4821.156297647933, 4821.252705830602, 4828.1068002419315, 4953.281774142729, 5017.046761115413, 5046.1926091825135, 5053.36832895888, 5074.746262686888, 5599.160125981095, 5638.4361563843695, 5639.379668236532, 5643.181738647873, 5649.0396632572565, 5661.745221465003, 5676.375598684142, 5689.459501347365, 5694.430556944314, 5697.259356283698, 5085.135526960388, 5123.769430375642, 5273.736313184364, 5305.814296499642, 5367.1680889462195, 5728.226689396878, 5780.653160810365, 5788.507976822018, 5789.131630255411, 5790.276215473066, 5540.14127810182, 5573.637713548606, 5577.972110139504, 5581.358143813432, 5581.916271255935, 5391.7034563099405, 5469.535089517356, 5545.7781688732, 5629.774809007594, 5636.408177141423, 5500.889982200333, 5540.667559946416, 5543.279373681396, 5544.63959842617, 5553.750081246354, 5522.199281104217, 5544.3346798384455, 5556.333240011225, 5557.777688892399, 5578.358488773762, 4170.854020109282, 4205.642520385802, 4257.1698518788535, 4317.287647538184, 4326.264535029052, 3863.150106976461, 3883.262180185812, 3884.126071633916, 3913.3738601824143, 3913.6477717005605, 5229.294045303835, 5246.868828279324, 5256.290400795843, 5256.868578285574, 5258.395284542326, 5361.839144825662, 5406.83779486616, 5464.371597266286, 5465.207544905967, 5496.532794712494, 5226.5818734501145, 5263.815766448156, 5276.947230527646, 5279.1817268323475, 5283.128283833124, 4738.573528382393, 4821.831235906727, 4863.221884498464, 4869.269609558594, 4873.0, 5588.776448941997, 5638.323401191801, 5671.489565939003, 5701.344345400332, 5734.139879018181, 5606.607537472338, 5608.270924779753, 5610.831675049755, 5612.7193640317, 5619.49424551776, 5564.054110801093, 5665.886682266414, 5759.136129580596, 5759.740811663569, 5765.4811067004175, 5489.835304940858, 5556.472135147316, 5565.860853478695, 5566.4990150886615, 5595.608307418604, 5535.7785688572, 5628.85927851807, 5630.943690563042, 5635.8591035224445, 5637.88724225505, 5273.78904843802, 5368.382635996911, 5392.325959255093, 5504.697241651747, 5549.0, 5453.10023846061, 5453.836384908459, 5454.400015998316, 5460.945390546044, 5465.562754979672, 5332.09354409759, 5339.759710812945, 5373.650712703662, 5389.434109418611, 5411.729413529387, 5333.813316533902, 5349.090654588651, 5465.398806131402, 5492.80775172867, 5553.194786755978, 5352.143657014859, 5357.812476563302, 5388.595855310789, 5393.217983392465, 5402.864928376822], "unit": "score", "name": "dojo.html", "value": 5161.5817192095055}, {"lowerIsBetter": false, "replicates": [564.3075476134493, 595.568213045542, 613.5398451161628, 635.8156134720931, 646.9611823290603, 29431.85284073579, 29966.550501742466, 29971.85014074932, 37867.810660946656, 38335.61664383356, 41225.0, 41886.0, 41934.16131677372, 42030.36954445686, 42083.368749468784, 8672.739817805445, 8808.867866982, 8853.070427605106, 8855.0, 8866.556672166398, 8888.777780555472, 9082.318826088036, 9082.86375704365, 9083.591238394256, 9086.0, 9020.54897255138, 9076.59155338008, 9103.772405689844, 9125.361224714272, 9131.086891310882, 8983.326250531203, 9086.227670648002, 9094.454332740057, 9099.499527526017, 9105.317101217435, 8778.253848422892, 8974.19232269099, 8979.057198994076, 8994.370394072417, 8995.055519170459, 42030.36954445686, 42503.36244956328, 42509.57490425087, 42576.1484770306, 42586.78706606478, 3606.981965090184, 3689.8524059037604, 3702.962970370316, 3816.0, 4113.25961326961, 32067.51898721521, 32629.347413051604, 32648.0, 32756.344873102404, 33281.66718332834, 4321.978390108061, 4333.155034768221, 4406.1628290625, 4408.713433626804, 4418.536053714346, 300112.0, 300290.0, 300980.0, 301878.0, 302094.48952755315, 55212.44787552073, 56085.0, 61961.690191548754, 62302.0, 62357.0, 63938.6803065991, 65114.34885651083, 65355.67322163359, 65527.34472655308, 65613.34386656072, 15205.391784328724, 15291.464798732213, 15305.846941530664, 15310.157941313335, 15343.539693809204, 12417.813732794015, 12525.812112818316, 12529.18560293578, 12530.81203781944, 12530.937345313398, 20618.0, 21254.574908501745, 21266.149354025976, 21305.25431609886, 21307.68038479424, 7427.888581671279, 7515.098188217449, 7581.886271705929, 7610.086789585285, 7642.19756925526, 1065.3767545985531, 1065.504540388723, 1105.5135740274254, 1142.9314241145391, 1154.2596142890318, 29498.55752163719, 29512.409751804844, 30582.847085764428, 30760.38479230403, 31080.22299442532, 1144.3248483394837, 1150.505282728418, 1151.3264740126951, 1160.0893298760432, 1162.0645380468804, 12824.487020519075, 13218.60344189676, 13315.0, 13605.0, 14634.41456843059, 368356.0, 372323.0, 373060.0, 373820.0, 375955.0, 55234.171487427724, 55452.72273638606, 55529.0, 55547.0, 55689.16466253009, 1350.7366063617696, 1359.7688392973218, 1460.9561713148623, 1480.9185494797673, 1531.770234464817, 26302.4739505205, 26355.868220658773, 26360.0, 26637.866810666597, 26702.0, 41369.586304136574, 41706.16587668169, 41744.3738343919, 41768.0, 41796.58203417927, 188198.0, 189502.0, 189797.0, 189979.0, 190278.04860975608, 32474.35051299008, 32842.67157328396, 32886.67113328932, 33248.0, 33271.0, 45502.089958201315, 45561.54438455573, 45770.542294576626, 46471.53528464672, 46545.0, 37313.253734924605, 37652.43521347237, 37764.43353349647, 38038.0, 38968.41547376848, 38119.80940095282, 38310.61689383182, 38631.80684096562, 38800.22399552049, 39147.0, 38087.61912380841, 38112.61887381202, 38134.8093259543, 38233.80883095678, 38752.0, 33342.66657333493, 33976.83011584926, 34489.827550862086, 34687.82656086703, 34829.477557836144, 25997.350066248495, 26141.0, 26314.605280921183, 26442.338941526617, 26507.838232745355], "unit": "score", "name": "ext.html", "value": 18967.074788672606}, {"lowerIsBetter": false, "replicates": [382.29657430328206, 384.12036436560277, 384.353724606087, 384.76144790230063, 389.3400685837505, 14221.075630084064, 15336.923315383436, 16442.91778541107, 19365.322213722506, 19372.612547749035, 16542.0, 16726.83273167268, 17002.574935626617, 17004.829951700478, 17074.0, 5997.850053748659, 6189.0, 6209.316975132731, 6211.565190436671, 6211.968940155293, 4397.934030989538, 4574.245249533823, 4580.473245576768, 4581.862544123682, 6098.725557349908, 6479.0, 6525.445337146324, 6728.360805723449, 6740.292269311725, 6769.966150169267, 6444.194475690539, 6481.351864813504, 6569.901451478232, 6572.934270657304, 6587.868242635121, 6567.376099270562, 6576.276609572943, 6577.473802095821, 6580.506462015368, 6592.538522303393, 12574.43415046325, 13153.934230328787, 21807.127714891387, 22770.0, 22771.544569108526, 2094.2251366994155, 2169.8698078115362, 2173.6413491773837, 2184.803367696915, 2196.2752291743686, 9908.455034973074, 10062.89937100627, 10182.439965801877, 10917.672469825919, 13614.183149010993, 1755.0, 1849.630073985195, 1962.9705554416696, 1988.8210061094426, 2006.067178761868, 56209.71895140498, 57137.0, 57755.422445775424, 58216.0, 58771.41228587745, 10996.835047474295, 11021.779564408667, 11047.171462140372, 11056.391898445663, 11112.722181945353, 14283.0, 14410.495632653017, 14449.349779259748, 14491.565253042425, 14504.419823207165, 7879.684812607432, 7968.561729104839, 8257.669693212325, 8337.416380853281, 8338.207870252316, 8002.1997800219515, 8053.476524025919, 8073.354131669453, 8105.8378832424205, 8121.431499795076, 4291.721038132574, 4689.296605509201, 4755.453122890843, 4757.405324334458, 4772.689775164603, 1806.4580625812466, 1835.476889086604, 1952.0434986856337, 1953.8143876331726, 1979.7327360806396, 919.6459363145237, 973.8101070291225, 980.2990861534038, 999.6101520407047, 1040.0639424517994, 13632.386542605607, 15800.604984875241, 16958.830411695973, 17078.23147958345, 17240.913795431192, 968.0851595242428, 976.077606661712, 1030.3714734012246, 1072.2172813845937, 1111.288775183883, 9923.851142232872, 10282.331648442827, 10377.429241391645, 10388.844167337496, 10425.11386532138, 538920.0, 553681.0, 566900.0, 571001.0, 573949.0, 69696.30303697, 69973.65013174902, 72774.86649946844, 78688.21311786924, 82535.587322063, 1183.0299154693241, 1195.491915935724, 1239.913206075566, 1249.506444954238, 1294.3592921503916, 15715.292811823267, 15761.211939402754, 15832.28754706018, 15873.444429444913, 16388.672226555642, 34157.65842341545, 34222.82888585541, 34528.48207276943, 35402.29195416026, 35508.82245588859, 43328.56671433245, 45476.54523454723, 45959.3106103402, 47947.5205247957, 50512.0, 7328.5969271690565, 7586.468947173645, 7733.845323093619, 7876.527408355517, 7912.0, 9661.516924153624, 11320.660380188607, 11573.826392603949, 11725.0, 12128.575499857463, 9773.511324433892, 9870.309078364446, 9945.651902183388, 9989.250806189419, 10343.793124137324, 8757.649694012169, 10248.128909042516, 10509.527071281658, 10513.842292365467, 10650.041496265374, 10266.230032747722, 10438.582456701646, 10584.8941510587, 10667.51996160159, 10873.401962892116, 7943.96728425301, 8039.758807235792, 8106.148854370206, 8123.0, 8178.959105204436, 8992.370534062815, 10150.340227885164, 10232.437215953194, 10253.692389228336, 10577.31247468912], "unit": "score", "name": "jquery.html", "value": 8719.199336294185}, {"lowerIsBetter": false, "replicates": [1537.2544316006738, 1557.8364271751466, 1777.6000399910022, 1837.8345948864599, 1904.0574915416862, 7749.0, 7972.242636949495, 7973.760787176379, 7975.680972761097, 7982.521048737072, 7840.0, 7877.8030549236155, 7878.724244651438, 7879.763607091796, 7879.9212007879905, 2371.4427109629223, 2393.1863166523335, 2402.771736685012, 2407.422218667516, 2409.6265078912797, 2364.3213318543853, 2393.9880300598475, 2398.556267090585, 2401.1235898896953, 2401.267613377919, 2008.0662491941243, 2055.239561362298, 2298.138198175684, 2332.54515369503, 2344.6834677318516, 2326.581215381231, 2338.0998315648512, 2342.929712108631, 2344.2146880794867, 2352.929412117639, 2275.2946586558055, 2289.6107661697383, 2305.0, 2306.1006207579057, 2306.815454763615, 6869.210040845317, 6998.545094568837, 7269.636518174123, 7375.151857536398, 7378.815529611749, 4686.554777296152, 4777.116233496779, 4785.521447855222, 4793.832215872428, 4803.423589169322, 3176.8252746098956, 3178.3484385700876, 3215.469447541153, 3226.6450690424035, 3309.338132373535, 1052.3896140238644, 1052.9420881851572, 1082.3289560472558, 1088.2708585247904, 1089.6186334782842, 11058.11535077192, 11060.115190784718, 11060.668179954615, 11112.666620001413, 11137.276077054965, 4482.21561226784, 4523.0, 4535.614472769786, 4538.614217791524, 4574.611158051536, 9491.715248542554, 9537.666181683608, 9543.141117299476, 9557.092076252884, 9562.856557151648, 4892.363992680928, 4892.804287828447, 4898.02039592083, 4926.950730492721, 4930.654854160174, 4444.488883778342, 4508.256137737302, 4513.480949690762, 4516.254817955067, 4521.412216411911, 3827.119762454651, 3832.770033797981, 3847.2882516734494, 3864.574896761354, 3868.1103346230525, 1225.6935766058486, 1235.604606525921, 1243.055277988717, 1247.5384107880143, 1255.29076072019, 1437.360374633278, 1437.5687293812023, 1440.2942558146642, 1455.3523681961426, 1458.4457905995866, 7832.804179895548, 7834.921650783534, 7844.607769611611, 7845.058592968766, 7852.960735196401, 535.6437968750815, 540.0737734784863, 549.0556243261584, 549.4999550409109, 551.1264645536869, 5697.800576979786, 5984.910226346608, 6027.578069535178, 6028.849278768066, 6032.155498230251, 8333.583290840572, 9529.0, 9717.319787614799, 9823.803523929482, 9826.263030272758, 9435.386699864486, 9581.425114493153, 9658.517074146264, 9675.951620241854, 9987.450690211963, 7720.15078341382, 7870.606469676493, 7880.84238315242, 7881.172476889844, 7887.645055972495, 7680.385569154342, 7770.611469426619, 7778.494397864347, 7794.727184548514, 7846.960765196138, 8763.07987661312, 8792.0, 8810.383273170817, 8850.911490885266, 8958.596863141043, 8893.599788009426, 9086.45481271126, 9122.407043542149, 9127.954360228156, 9147.0, 7280.325525129356, 7343.082114735658, 7345.3021962913435, 7354.816129596589, 7357.558546487228, 7684.769456916301, 7898.960505197438, 7909.288164065261, 7909.604519774103, 7911.090224624242, 7263.34629883313, 7421.888671669822, 7451.40388768908, 7580.0, 7708.498947568614, 7374.373178279691, 7411.666475008746, 7470.0662417197855, 7487.925120748723, 7555.0, 7507.662155203138, 7528.058992625922, 7582.696692132253, 7598.430117741081, 7619.885701714589, 6907.7236910525025, 6935.757248496278, 6977.0, 6987.056747339044, 6990.965045174741, 6947.583145011114, 6990.2660220678135, 6994.825129371807, 7044.929550704427, 7107.0], "unit": "score", "name": "mootools.html", "value": 4622.115200690509}, {"lowerIsBetter": false, "replicates": [366.9688076513497, 369.3849740182596, 370.3722190886448, 375.90038639760485, 380.9790461524615, 5999.940000599992, 6071.848203794902, 6115.480184184344, 6120.357362476942, 6139.969300153504, 6047.15339852421, 6059.242594675666, 6062.302835173957, 6062.8484287892825, 6071.908921366183, 4537.478190008142, 4659.347691323217, 4661.813527458915, 4666.789994450241, 4749.216379297412, 4705.764711764416, 4706.176419126657, 4707.6233901287815, 4714.834980775673, 4719.174144524694, 4441.267190913495, 4576.725396476222, 4680.5085466026085, 4686.531346865303, 4692.741899195543, 4537.523560026199, 4566.6575006874455, 4602.907941841145, 4613.930791038137, 4641.419822522184, 4018.537868145142, 4045.37296719009, 4057.2088442753675, 4067.837286508536, 4069.776162311072, 5585.134304182858, 5710.457506536873, 5801.3328467225965, 5804.564657650651, 5815.941840581625, 5291.656042357235, 5292.126799078147, 5433.701146436944, 5436.972815135899, 5446.21029950655, 6344.524160687967, 6357.364263573606, 6362.872742545123, 6366.649834259114, 6367.554271201017, 4581.129585378767, 4581.977090114561, 4582.404287442644, 4584.174848527264, 4590.885227869297, 6439.484841212692, 6668.699908504129, 6677.298883617199, 6677.666116694194, 6684.131062961833, 4553.043860789205, 4556.498785133699, 4556.567126123013, 4562.178807814559, 4565.178267911808, 4611.2852507861335, 4613.8846528836375, 4617.676762626651, 4618.35343051973, 4628.514006029386, 5232.2674825524455, 5309.964556911365, 5328.120860058125, 5337.8131765388025, 5338.706371149547, 6372.6495042773095, 6431.5819471734185, 6438.484921206292, 6440.0, 6447.1296374989715, 1651.2321770376832, 1672.2140593920838, 1672.7992640883172, 1672.9079900605584, 1674.1712852138269, 1136.4772204785727, 1139.1911742662803, 1143.0798207442922, 1146.5471138900089, 1173.3136115372602, 6130.049842274455, 6139.048447490646, 6144.047672610753, 6145.231846019247, 6145.754169833246, 6607.339266073354, 6614.8346291343105, 6622.63575503352, 6626.503012274003, 6630.436412904861, 6025.758969641253, 6147.723352449061, 6150.538709596798, 6151.569390142647, 6159.076138579249, 3539.8938031859084, 3577.58857731359, 3580.1765593913024, 3580.695640870503, 3582.0865679252147, 6797.830054248683, 6798.184217893786, 6799.150106236721, 6806.217285012188, 6807.149106361705, 6490.286068532458, 6513.348665133543, 6640.0703901453835, 6694.397504224643, 6744.426723728538, 6796.388325050769, 6845.863082738417, 6859.382655561023, 6875.931240687629, 6879.071325371011, 6655.667216639052, 6657.400833924777, 6665.566738162004, 6666.666666666744, 6670.166229221348, 6408.871822563616, 6555.541112122106, 6564.868702625825, 6566.409023187936, 6566.8358291041195, 6845.418139458003, 6857.5199736018, 6859.416949559144, 6859.794206173623, 6860.759873404407, 4706.411698537683, 4709.17589421843, 4716.575508204278, 4717.457492388419, 4721.6071258978, 6540.149780528501, 6683.264840867598, 6683.933160668331, 6686.899696504654, 6690.698918548775, 6511.641859697762, 6513.7068831903625, 6524.934750652433, 6527.249366322933, 6528.020796880506, 6508.739650413931, 6514.185726784152, 6515.250746164252, 6583.078369028436, 6588.670566471753, 6182.103594978613, 6364.427201551883, 6381.234251889803, 6395.296517382991, 6403.455706265019, 6516.283208846929, 6527.836804079936, 6536.673166341759, 6536.803895883131, 6541.574797638138, 6332.810015699536, 6364.968175159094, 6379.712912918837, 6381.3937675920715, 6387.297397286387], "unit": "score", "name": "prototype.html", "value": 4882.34870126715}, {"lowerIsBetter": false, "replicates": [763.3664058831171, 776.8795836645322, 866.5017614871449, 914.9405288656233, 948.1892981500816, 14545.854541454595, 14683.632909177277, 14717.92641036796, 14719.043262187965, 14719.632009199748, 13842.584722458318, 13910.026298159133, 13911.582652520441, 15084.773728394055, 15444.845551544482, 732.1287667675449, 905.3391024552097, 915.697819719491, 915.9404638698496, 917.0325306801321, 750.5571712689513, 750.9849803003937, 752.5898385379982, 900.4732231644496, 918.9264858811279, 943.0, 947.8625599288099, 951.1202138022336, 951.4386511957944, 951.5432592355673, 944.919681827042, 949.6960972488806, 954.374884450686, 956.3687965942514, 956.9617215311379, 576.2479963647438, 582.676614478964, 582.7785441532233, 584.0771580902165, 685.2838783471235, 15045.322960466805, 15047.623809404853, 15070.773938390932, 15125.16811575363, 15243.314050867737, 13537.796933046013, 13684.452621895112, 14026.859731402657, 14067.859321406757, 14068.507602233974, 11576.594819181373, 11641.767164656743, 11681.299122052618, 11729.354885481294, 12027.338496382696, 3800.0, 3822.7515211511163, 3827.2536855313224, 3859.671927886133, 3865.768053916774, 53659.19511207335, 53937.0, 54852.45147548553, 54943.725281373736, 54955.0, 10654.73363165927, 11036.889631103746, 11139.610113645984, 11253.930876566714, 11288.503946436253, 19417.902910485358, 19492.805071949384, 19505.414837554898, 19527.218911243675, 19556.90221548883, 7800.063992320957, 7880.724174653859, 7899.328557072598, 8037.23646253605, 8080.191980801873, 4516.8644940651175, 4566.589006989387, 4572.291294849304, 4579.656525760514, 4592.839250626212, 3233.1593785615437, 3270.9182270442952, 3272.476403775432, 3274.2305558193807, 3274.476083826624, 562.9493345598834, 571.451406649621, 572.6335145506879, 578.0721941284178, 579.828950459607, 595.0687174571781, 730.4448619049455, 753.7587971849065, 770.7821641805933, 770.9537427754352, 8742.606582703793, 9507.809843803223, 9861.901380986099, 9913.65302214419, 9922.107010369102, 539.3904887477125, 632.0868277266201, 761.9923800762032, 764.81262090787, 782.2334112569714, 4260.595243451867, 4450.888727781831, 4479.910401791946, 4480.775961201927, 4543.636509079266, 61275.38724612786, 62166.0, 62477.687611562564, 62913.37086629167, 62965.0, 50799.492005079475, 52010.219846702326, 52616.21075683868, 52721.47278527165, 52824.73587632114, 48753.75623121862, 51489.742551287, 51523.742381288605, 52082.739586301825, 52195.73902130465, 9612.279079068958, 9624.133827955518, 9649.276304277068, 9674.935757066858, 9724.31929764938, 36811.07972300714, 37230.627693722716, 37585.49658013758, 38286.23427531489, 39549.0, 49320.75339623279, 49784.751076244385, 50216.49783502118, 50345.244821326974, 50362.055398958626, 12408.255504669749, 13281.734365312834, 13312.467501300227, 13359.799603005767, 13432.597022089352, 13194.340282986004, 13712.725745484835, 13889.236092015037, 14348.354324055652, 14381.640458988191, 12813.551525696928, 12828.0, 13009.7580657212, 13187.406566704713, 13509.392077356739, 13010.544630937871, 13131.671708207372, 13148.474061037452, 13258.270795105977, 13433.66415839612, 10561.0, 12290.81563776562, 12371.628851134481, 12413.193142445713, 12487.875121249035, 9919.801603968024, 9990.750231244278, 9993.950030249802, 10091.646792362231, 10356.171506279328, 10311.845322320321, 10559.0, 10817.56729730802, 10824.079953204066, 10881.673549793519], "unit": "score", "name": "yui.html", "value": 6880.845642585294}], "name": "dromaeo_css", "value": 7140.602340931162}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 109.0, 109.0, 110.0, 101.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 156.0, 159.0, 123.0, 151.0, 153.0, 131.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 158.0, 164.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 73.0, 148.0, 74.0, 74.0, 73.0, 75.0, 146.0, 72.0], "unit": "score", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 140.0, 94.0, 95.0, 95.0, 138.0, 95.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 57.0, 55.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 81.0, 79.0, 79.0, 79.0, 78.0, 79.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 111.0, 115.0, 110.0, 118.0, 108.0, 111.0, 116.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.8}, {"lowerIsBetter": true, "replicates": [137.0, 143.0, 137.0, 135.0, 135.0, 135.0, 137.0, 135.0, 134.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.4}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1473.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8374792703151], "unit": "score", "name": "Richards", "value": 212.87106}, {"lowerIsBetter": false, "replicates": [175.28483786152498], "unit": "score", "name": "DeltaBlue", "value": 377.20318999999995}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [972.7626459143969], "unit": "score", "name": "RayTrace", "value": 760.7086919999998}, {"lowerIsBetter": false, "replicates": [554.9389567147614], "unit": "score", "name": "Earley", "value": 1200.966326}, {"lowerIsBetter": false, "replicates": [10763.440860215054], "unit": "score", "name": "Boyer", "value": 61.919139860139865}, {"lowerIsBetter": false, "replicates": [40400.0], "unit": "score", "name": "RegExp", "value": 22.549133663366337}, {"lowerIsBetter": false, "replicates": [519.4805194805194], "unit": "score", "name": "Splay", "value": 156.87017499999993}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21895.32474984627}]} 12:37:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "21895.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1473.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7140.60"}}} 12:37:12 INFO - Return code: 0 12:37:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:37:12 INFO - # TBPL SUCCESS # 12:37:12 INFO - Running post-action listener: _resource_record_post_action 12:37:12 INFO - Running post-run listener: _resource_record_post_run 12:37:13 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 61440; Write bytes: 235089920; Read time: 76; Write time: 116920 12:37:13 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 10166272; Read time: 0; Write time: 988 12:37:13 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 224923648; Read time: 44; Write time: 115932 12:37:13 INFO - Running post-run listener: _upload_blobber_files 12:37:13 INFO - Blob upload gear active. 12:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:13 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 12:37:13 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:37:13 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:37:13 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:14 INFO - (blobuploader) - INFO - Done attempting. 12:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:15 INFO - (blobuploader) - INFO - Done attempting. 12:37:15 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:15 INFO - Return code: 0 12:37:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/adb2fd23ba4e0123895aa0b0c0a3b619e286f47d4f92f57be899f2c00238e02883fac558957efddfc55911ab30fe342461b5c4e05e51e92406324ffa1c216f88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d54ff7d5862843a8b889faf97e9a2cee73f3d72dbee7b1990eb26a8e81a46b32184718a505053e3cb11ef0d30f9c8231955b186b637c1b575d057b4c66a50fd8"} 12:37:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:15 INFO - Contents: 12:37:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/adb2fd23ba4e0123895aa0b0c0a3b619e286f47d4f92f57be899f2c00238e02883fac558957efddfc55911ab30fe342461b5c4e05e51e92406324ffa1c216f88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d54ff7d5862843a8b889faf97e9a2cee73f3d72dbee7b1990eb26a8e81a46b32184718a505053e3cb11ef0d30f9c8231955b186b637c1b575d057b4c66a50fd8"} 12:37:15 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:15 INFO - Copying logs to upload dir... 12:37:15 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.055756 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 12:37:15.431987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:37:15.435673) ========= 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/adb2fd23ba4e0123895aa0b0c0a3b619e286f47d4f92f57be899f2c00238e02883fac558957efddfc55911ab30fe342461b5c4e05e51e92406324ffa1c216f88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d54ff7d5862843a8b889faf97e9a2cee73f3d72dbee7b1990eb26a8e81a46b32184718a505053e3cb11ef0d30f9c8231955b186b637c1b575d057b4c66a50fd8"} build_url:https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011562 build_url: 'https://queue.taskcluster.net/v1/task/LA2BoNiITbWQbs9K-_c92g/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/adb2fd23ba4e0123895aa0b0c0a3b619e286f47d4f92f57be899f2c00238e02883fac558957efddfc55911ab30fe342461b5c4e05e51e92406324ffa1c216f88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/d54ff7d5862843a8b889faf97e9a2cee73f3d72dbee7b1990eb26a8e81a46b32184718a505053e3cb11ef0d30f9c8231955b186b637c1b575d057b4c66a50fd8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:37:15.460971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:37:15.461327) ========= 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=836cfdc75598d54cb747368e000001a9-1457726828.82543-262307799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:37:15.548340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:37:15.549079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:37:15.549766) ========= ========= Total master_lag: 0.27 =========