builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1457728744.29 results: success (0) buildid: 20160311100842 builduid: 692c1b1d85fe45bfa6a737efc7ffd8dd revision: 4668361a486d865c53a9ab683563a59b418c350a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.286572) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.286985) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.287320) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.309158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.309490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.323312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.323653) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.373341) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.373682) ========= 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:39:04.374071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.374420) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 12:39: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-03-11 12:39:04 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.550760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.551165) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.601649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:04.602071) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 4668361a486d865c53a9ab683563a59b418c350a --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 4668361a486d865c53a9ab683563a59b418c350a --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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 12:39:04,838 truncating revision to first 12 chars 2016-03-11 12:39:04,838 Setting DEBUG logging. 2016-03-11 12:39:04,838 attempt 1/10 2016-03-11 12:39:04,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/4668361a486d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 12:39:05,096 unpacking tar archive at: date-4668361a486d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:05.183690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:05.184079) ========= echo 4668361a486d865c53a9ab683563a59b418c350a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4668361a486d865c53a9ab683563a59b418c350a'] 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4668361a486d865c53a9ab683563a59b418c350a program finished with exit code 0 elapsedTime=0.004004 script_repo_revision: '4668361a486d865c53a9ab683563a59b418c350a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:05.233304) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:05.233653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 12:39:05.244544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-11 12:39:05.244874) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:05 INFO - MultiFileLogger online at 20160311 12:39:05 in /builds/slave/test 12:39: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:39:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:05 INFO - {'append_to_log': False, 12:39:05 INFO - 'base_work_dir': '/builds/slave/test', 12:39:05 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:39:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:05 INFO - 'branch': 'Date-Non-PGO', 12:39:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:05 INFO - 'config_files': ('talos/linux_config.py',), 12:39:05 INFO - 'default_actions': ('clobber', 12:39:05 INFO - 'read-buildbot-config', 12:39:05 INFO - 'download-and-extract', 12:39:05 INFO - 'populate-webroot', 12:39:05 INFO - 'create-virtualenv', 12:39:05 INFO - 'install', 12:39:05 INFO - 'run-tests'), 12:39:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:05 INFO - 'download_minidump_stackwalk': True, 12:39:05 INFO - 'download_symbols': 'ondemand', 12:39:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:05 INFO - 'installer_path': 'installer.exe', 12:39:05 INFO - 'log_level': 'info', 12:39:05 INFO - 'log_name': 'talos', 12:39:05 INFO - 'log_to_console': True, 12:39:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:05 INFO - 'opt_config_files': (), 12:39:05 INFO - 'pip_index': False, 12:39:05 INFO - 'sps_profile': False, 12:39:05 INFO - 'sps_profile_interval': 0, 12:39:05 INFO - 'suite': 'dromaeojs', 12:39:05 INFO - 'system_bits': '32', 12:39:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:05 INFO - 'title': 'talos-linux64-ix-012', 12:39:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:05 INFO - 'use_talos_json': True, 12:39:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:05 INFO - 'work_dir': 'build'} 12:39:05 INFO - ##### 12:39:05 INFO - ##### Running clobber step. 12:39:05 INFO - ##### 12:39:05 INFO - Running pre-action listener: _resource_record_pre_action 12:39:05 INFO - Running main action method: clobber 12:39:05 INFO - rmtree: /builds/slave/test/build 12:39:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:06 INFO - Running post-action listener: _resource_record_post_action 12:39:06 INFO - ##### 12:39:06 INFO - ##### Running read-buildbot-config step. 12:39:06 INFO - ##### 12:39:06 INFO - Running pre-action listener: _resource_record_pre_action 12:39:06 INFO - Running main action method: read_buildbot_config 12:39:06 INFO - Using buildbot properties: 12:39:06 INFO - { 12:39:06 INFO - "project": "", 12:39:06 INFO - "product": "firefox", 12:39:06 INFO - "script_repo_revision": "production", 12:39:06 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 12:39:06 INFO - "repository": "", 12:39:06 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 12:39:06 INFO - "buildid": "20160311100842", 12:39:06 INFO - "pgo_build": "False", 12:39:06 INFO - "basedir": "/builds/slave/test", 12:39:06 INFO - "buildnumber": 4, 12:39:06 INFO - "slavename": "talos-linux64-ix-012", 12:39:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:39:06 INFO - "platform": "ubuntu64_hw", 12:39:06 INFO - "scheduler": "tests-date-linux64-talos", 12:39:06 INFO - "branch": "date", 12:39:06 INFO - "repo_path": "projects/date", 12:39:06 INFO - "revision": "4668361a486d865c53a9ab683563a59b418c350a", 12:39:06 INFO - "stage_platform": "linux64", 12:39:06 INFO - "builduid": "692c1b1d85fe45bfa6a737efc7ffd8dd", 12:39:06 INFO - "slavebuilddir": "test" 12:39:06 INFO - } 12:39:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:39:06 INFO - Running post-action listener: _resource_record_post_action 12:39:06 INFO - ##### 12:39:06 INFO - ##### Running download-and-extract step. 12:39:06 INFO - ##### 12:39:06 INFO - Running pre-action listener: _resource_record_pre_action 12:39:06 INFO - Running main action method: download_and_extract 12:39:06 INFO - mkdir: /builds/slave/test/build/tests 12:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:06 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json 12:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json 12:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:39:06 INFO - Downloaded 1412 bytes. 12:39:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:39:06 INFO - Using the following test package requirements: 12:39:06 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:06 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:06 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:39:06 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'jsshell-linux-x86_64.zip'], 12:39:06 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:06 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:06 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:39:06 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:39:06 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:06 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:39:06 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:39:06 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:06 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:06 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:08 INFO - Downloaded 23091316 bytes. 12:39:08 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:39:08 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:39:09 INFO - Return code: 0 12:39:09 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:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:09 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:39:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:11 INFO - Downloaded 23091316 bytes. 12:39:11 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:39:11 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:39:12 INFO - Return code: 0 12:39: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:39:12 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:13 INFO - Downloaded 10706668 bytes. 12:39:13 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:39:13 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:39:14 INFO - Return code: 0 12:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:14 INFO - https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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:39:15 INFO - Downloaded 52858903 bytes. 12:39:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:15 INFO - mkdir: /builds/slave/test/properties 12:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:15 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:15 INFO - Contents: 12:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:39:16 INFO - Running post-action listener: _resource_record_post_action 12:39:16 INFO - Running post-action listener: set_extra_try_arguments 12:39:16 INFO - ##### 12:39:16 INFO - ##### Running populate-webroot step. 12:39:16 INFO - ##### 12:39:16 INFO - Running pre-action listener: _resource_record_pre_action 12:39:16 INFO - Running main action method: populate_webroot 12:39:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:16 INFO - '--tppagecycles', 12:39:16 INFO - '7'], 12:39:16 INFO - 'tests': ['tsvgm']}}, 12:39:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:39:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'tests': ['damp', 'tps']}, 12:39:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['damp', 'tps']}, 12:39:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:39:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:16 INFO - 'other': {'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'other_l64': {'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'other_nol64': {'tests': ['a11yr', 12:39:16 INFO - 'ts_paint', 12:39:16 INFO - 'tpaint', 12:39:16 INFO - 'sessionrestore', 12:39:16 INFO - 'sessionrestore_no_auto_restore']}, 12:39:16 INFO - 'svgr': {'tests': ['tsvgx', 12:39:16 INFO - 'tsvgr_opacity', 12:39:16 INFO - 'tart', 12:39:16 INFO - 'tscrollx', 12:39:16 INFO - 'cart']}, 12:39:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['tsvgx', 12:39:16 INFO - 'tsvgr_opacity', 12:39:16 INFO - 'tart', 12:39:16 INFO - 'tscrollx', 12:39:16 INFO - 'cart']}, 12:39:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'tests': ['tp5o']}, 12:39:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'talos_options': ['--e10s'], 12:39:16 INFO - 'tests': ['tp5o']}, 12:39:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'talos_options': ['--xperf_path', 12:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:16 INFO - 'tests': ['tp5n']}, 12:39:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:16 INFO - 'talos_options': ['--e10s', 12:39:16 INFO - '--xperf_path', 12:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:16 INFO - 'tests': ['tp5n']}}, 12:39:16 INFO - 'talos.zip': {'path': '', 12:39:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:16 INFO - Running post-action listener: _resource_record_post_action 12:39:16 INFO - ##### 12:39:16 INFO - ##### Running create-virtualenv step. 12:39:16 INFO - ##### 12:39:16 INFO - Running pre-action listener: _resource_record_pre_action 12:39:16 INFO - Running main action method: create_virtualenv 12:39:16 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:16 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:39:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:16 INFO - Using real prefix '/usr' 12:39:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:16 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:18 INFO - Installing pip.................done. 12:39:18 INFO - Return code: 0 12:39:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:18 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:18 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:39:18 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:39:18 INFO - Using env: {'DISPLAY': ':0', 12:39:18 INFO - 'HOME': '/home/cltbld', 12:39:18 INFO - 'LANG': 'en_US.UTF-8', 12:39:18 INFO - 'LANGUAGE': 'en_US:en', 12:39:18 INFO - 'LOGNAME': 'cltbld', 12:39:18 INFO - 'MAIL': '/var/mail/cltbld', 12:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:18 INFO - 'MOZ_NO_REMOTE': '1', 12:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:18 INFO - 'NO_EM_RESTART': '1', 12:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:18 INFO - 'PWD': '/builds/slave/test', 12:39:18 INFO - 'SHELL': '/bin/bash', 12:39:18 INFO - 'SHLVL': '1', 12:39:18 INFO - 'TERM': 'linux', 12:39:18 INFO - 'TMOUT': '86400', 12:39:18 INFO - 'USER': 'cltbld', 12:39:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:18 INFO - '_': '/tools/buildbot/bin/python'} 12:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:18 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:39:18 INFO - Cleaning up... 12:39:18 INFO - Return code: 0 12:39:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:18 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:18 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:39:18 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:39:18 INFO - Using env: {'DISPLAY': ':0', 12:39:18 INFO - 'HOME': '/home/cltbld', 12:39:18 INFO - 'LANG': 'en_US.UTF-8', 12:39:18 INFO - 'LANGUAGE': 'en_US:en', 12:39:18 INFO - 'LOGNAME': 'cltbld', 12:39:18 INFO - 'MAIL': '/var/mail/cltbld', 12:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:18 INFO - 'MOZ_NO_REMOTE': '1', 12:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:18 INFO - 'NO_EM_RESTART': '1', 12:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:18 INFO - 'PWD': '/builds/slave/test', 12:39:18 INFO - 'SHELL': '/bin/bash', 12:39:18 INFO - 'SHLVL': '1', 12:39:18 INFO - 'TERM': 'linux', 12:39:18 INFO - 'TMOUT': '86400', 12:39:18 INFO - 'USER': 'cltbld', 12:39:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:18 INFO - '_': '/tools/buildbot/bin/python'} 12:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:19 INFO - Downloading/unpacking psutil>=0.7.1 12:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:21 INFO - Installing collected packages: psutil 12:39:21 INFO - Running setup.py install for psutil 12:39:21 INFO - building 'psutil._psutil_linux' extension 12:39:21 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:39:21 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:39:21 INFO - building 'psutil._psutil_posix' extension 12:39:21 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:39:21 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:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:21 INFO - Successfully installed psutil 12:39:21 INFO - Cleaning up... 12:39:21 INFO - Return code: 0 12:39:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:39: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:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:21 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:21 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:39:21 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:39:21 INFO - Using env: {'DISPLAY': ':0', 12:39:21 INFO - 'HOME': '/home/cltbld', 12:39:21 INFO - 'LANG': 'en_US.UTF-8', 12:39:21 INFO - 'LANGUAGE': 'en_US:en', 12:39:21 INFO - 'LOGNAME': 'cltbld', 12:39:21 INFO - 'MAIL': '/var/mail/cltbld', 12:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:21 INFO - 'MOZ_NO_REMOTE': '1', 12:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:21 INFO - 'NO_EM_RESTART': '1', 12:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:21 INFO - 'PWD': '/builds/slave/test', 12:39:21 INFO - 'SHELL': '/bin/bash', 12:39:21 INFO - 'SHLVL': '1', 12:39:21 INFO - 'TERM': 'linux', 12:39:21 INFO - 'TMOUT': '86400', 12:39:21 INFO - 'USER': 'cltbld', 12:39:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:21 INFO - '_': '/tools/buildbot/bin/python'} 12:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:23 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:39:23 INFO - Installing collected packages: mozsystemmonitor 12:39:23 INFO - Running setup.py install for mozsystemmonitor 12:39:23 INFO - Successfully installed mozsystemmonitor 12:39:23 INFO - Cleaning up... 12:39:23 INFO - Return code: 0 12:39:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:23 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:23 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:39:23 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:39:23 INFO - Using env: {'DISPLAY': ':0', 12:39:23 INFO - 'HOME': '/home/cltbld', 12:39:23 INFO - 'LANG': 'en_US.UTF-8', 12:39:23 INFO - 'LANGUAGE': 'en_US:en', 12:39:23 INFO - 'LOGNAME': 'cltbld', 12:39:23 INFO - 'MAIL': '/var/mail/cltbld', 12:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:23 INFO - 'MOZ_NO_REMOTE': '1', 12:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:23 INFO - 'NO_EM_RESTART': '1', 12:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:23 INFO - 'PWD': '/builds/slave/test', 12:39:23 INFO - 'SHELL': '/bin/bash', 12:39:23 INFO - 'SHLVL': '1', 12:39:23 INFO - 'TERM': 'linux', 12:39:23 INFO - 'TMOUT': '86400', 12:39:23 INFO - 'USER': 'cltbld', 12:39:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:23 INFO - '_': '/tools/buildbot/bin/python'} 12:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:24 INFO - Downloading/unpacking blobuploader==1.2.4 12:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:25 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:39:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:39:26 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:39:26 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:39:26 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:39:26 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:39:26 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:39:26 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:39:26 INFO - Downloading docopt-0.6.1.tar.gz 12:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:39:26 INFO - Installing collected packages: blobuploader, requests, docopt 12:39:26 INFO - Running setup.py install for blobuploader 12:39:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:39:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:39:26 INFO - Running setup.py install for requests 12:39:27 INFO - Running setup.py install for docopt 12:39:27 INFO - Successfully installed blobuploader requests docopt 12:39:27 INFO - Cleaning up... 12:39:27 INFO - Return code: 0 12:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:27 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:27 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:39:27 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:39:27 INFO - Using env: {'DISPLAY': ':0', 12:39:27 INFO - 'HOME': '/home/cltbld', 12:39:27 INFO - 'LANG': 'en_US.UTF-8', 12:39:27 INFO - 'LANGUAGE': 'en_US:en', 12:39:27 INFO - 'LOGNAME': 'cltbld', 12:39:27 INFO - 'MAIL': '/var/mail/cltbld', 12:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:27 INFO - 'MOZ_NO_REMOTE': '1', 12:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:27 INFO - 'NO_EM_RESTART': '1', 12:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:27 INFO - 'PWD': '/builds/slave/test', 12:39:27 INFO - 'SHELL': '/bin/bash', 12:39:27 INFO - 'SHLVL': '1', 12:39:27 INFO - 'TERM': 'linux', 12:39:27 INFO - 'TMOUT': '86400', 12:39:27 INFO - 'USER': 'cltbld', 12:39:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:27 INFO - '_': '/tools/buildbot/bin/python'} 12:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:27 INFO - Running setup.py (path:/tmp/pip-E1tZYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:27 INFO - Running setup.py (path:/tmp/pip-mPRmjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:27 INFO - Running setup.py (path:/tmp/pip-atE7T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:27 INFO - Running setup.py (path:/tmp/pip-ihwqFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:27 INFO - Running setup.py (path:/tmp/pip-1bsoNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:27 INFO - Running setup.py (path:/tmp/pip-Ix96v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:27 INFO - Running setup.py (path:/tmp/pip-JMyFCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:27 INFO - Running setup.py (path:/tmp/pip-aI5W7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:27 INFO - Running setup.py (path:/tmp/pip-RdsIvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:28 INFO - Running setup.py (path:/tmp/pip-DDguEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:28 INFO - Running setup.py (path:/tmp/pip-9sTuhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:28 INFO - Running setup.py (path:/tmp/pip-3H4XNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:28 INFO - Running setup.py (path:/tmp/pip-I3wsNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:28 INFO - Running setup.py (path:/tmp/pip-17gjox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:28 INFO - Running setup.py (path:/tmp/pip-v0hXhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:28 INFO - Running setup.py (path:/tmp/pip-SISC1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:28 INFO - Running setup.py (path:/tmp/pip-UDwdd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:39:28 INFO - Running setup.py install for manifestparser 12:39:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:39:28 INFO - Running setup.py install for mozcrash 12:39:28 INFO - Running setup.py install for mozdebug 12:39:28 INFO - Running setup.py install for mozdevice 12:39:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozfile 12:39:29 INFO - Running setup.py install for mozhttpd 12:39:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozinfo 12:39:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozInstall 12:39:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozleak 12:39:29 INFO - Running setup.py install for mozlog 12:39:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for moznetwork 12:39:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozprocess 12:39:29 INFO - Running setup.py install for mozprofile 12:39:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:39:29 INFO - Running setup.py install for mozrunner 12:39:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:39:30 INFO - Running setup.py install for mozscreenshot 12:39:30 INFO - Running setup.py install for moztest 12:39:30 INFO - Running setup.py install for mozversion 12:39:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:39:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:30 INFO - Cleaning up... 12:39:30 INFO - Return code: 0 12:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:30 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:30 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:39:30 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:39:30 INFO - Using env: {'DISPLAY': ':0', 12:39:30 INFO - 'HOME': '/home/cltbld', 12:39:30 INFO - 'LANG': 'en_US.UTF-8', 12:39:30 INFO - 'LANGUAGE': 'en_US:en', 12:39:30 INFO - 'LOGNAME': 'cltbld', 12:39:30 INFO - 'MAIL': '/var/mail/cltbld', 12:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:30 INFO - 'MOZ_NO_REMOTE': '1', 12:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:30 INFO - 'NO_EM_RESTART': '1', 12:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:30 INFO - 'PWD': '/builds/slave/test', 12:39:30 INFO - 'SHELL': '/bin/bash', 12:39:30 INFO - 'SHLVL': '1', 12:39:30 INFO - 'TERM': 'linux', 12:39:30 INFO - 'TMOUT': '86400', 12:39:30 INFO - 'USER': 'cltbld', 12:39:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:30 INFO - '_': '/tools/buildbot/bin/python'} 12:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:30 INFO - Running setup.py (path:/tmp/pip-jaO5i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:30 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:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:30 INFO - Running setup.py (path:/tmp/pip-xLaKa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:30 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:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:30 INFO - Running setup.py (path:/tmp/pip-8N3lbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:30 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:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:30 INFO - Running setup.py (path:/tmp/pip-e3JRko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:30 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:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:30 INFO - Running setup.py (path:/tmp/pip-QPJh6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:30 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:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:30 INFO - Running setup.py (path:/tmp/pip-fqYsrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:31 INFO - Running setup.py (path:/tmp/pip-zZ15Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:31 INFO - Running setup.py (path:/tmp/pip-zDZn8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:31 INFO - Running setup.py (path:/tmp/pip-U5RPCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:31 INFO - Running setup.py (path:/tmp/pip-SqNQCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:31 INFO - Running setup.py (path:/tmp/pip-dXM32H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:31 INFO - Running setup.py (path:/tmp/pip-NbP4pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:31 INFO - Running setup.py (path:/tmp/pip-HFoRuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:31 INFO - Running setup.py (path:/tmp/pip-hw3us2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:31 INFO - Running setup.py (path:/tmp/pip-mKs_eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:31 INFO - Running setup.py (path:/tmp/pip-RaaUU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:31 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:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:31 INFO - Running setup.py (path:/tmp/pip-AxfbHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:31 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:39:31 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:39:31 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:39:31 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:39:31 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:39:31 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:39:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:39: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:39: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:39: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:39: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:39: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:39: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:39:33 INFO - Downloading blessings-1.6.tar.gz 12:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:33 INFO - Installing collected packages: blessings 12:39:33 INFO - Running setup.py install for blessings 12:39:33 INFO - Successfully installed blessings 12:39:33 INFO - Cleaning up... 12:39:33 INFO - Return code: 0 12:39:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:34 INFO - Reading from file tmpfile_stdout 12:39:34 INFO - Current package versions: 12:39:34 INFO - argparse == 1.2.1 12:39:34 INFO - blessings == 1.6 12:39:34 INFO - blobuploader == 1.2.4 12:39:34 INFO - docopt == 0.6.1 12:39:34 INFO - manifestparser == 1.1 12:39:34 INFO - mozInstall == 1.12 12:39:34 INFO - mozcrash == 0.16 12:39:34 INFO - mozdebug == 0.1 12:39:34 INFO - mozdevice == 0.48 12:39:34 INFO - mozfile == 1.2 12:39:34 INFO - mozhttpd == 0.7 12:39:34 INFO - mozinfo == 0.9 12:39:34 INFO - mozleak == 0.1 12:39:34 INFO - mozlog == 3.1 12:39:34 INFO - moznetwork == 0.27 12:39:34 INFO - mozprocess == 0.22 12:39:34 INFO - mozprofile == 0.28 12:39:34 INFO - mozrunner == 6.11 12:39:34 INFO - mozscreenshot == 0.1 12:39:34 INFO - mozsystemmonitor == 0.0 12:39:34 INFO - moztest == 0.7 12:39:34 INFO - mozversion == 1.4 12:39:34 INFO - psutil == 3.1.1 12:39:34 INFO - requests == 1.2.3 12:39:34 INFO - wsgiref == 0.1.2 12:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:34 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:34 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:39:34 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:39:34 INFO - Using env: {'DISPLAY': ':0', 12:39:34 INFO - 'HOME': '/home/cltbld', 12:39:34 INFO - 'LANG': 'en_US.UTF-8', 12:39:34 INFO - 'LANGUAGE': 'en_US:en', 12:39:34 INFO - 'LOGNAME': 'cltbld', 12:39:34 INFO - 'MAIL': '/var/mail/cltbld', 12:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:34 INFO - 'MOZ_NO_REMOTE': '1', 12:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:34 INFO - 'NO_EM_RESTART': '1', 12:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:34 INFO - 'PWD': '/builds/slave/test', 12:39:34 INFO - 'SHELL': '/bin/bash', 12:39:34 INFO - 'SHLVL': '1', 12:39:34 INFO - 'TERM': 'linux', 12:39:34 INFO - 'TMOUT': '86400', 12:39:34 INFO - 'USER': 'cltbld', 12:39:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:34 INFO - '_': '/tools/buildbot/bin/python'} 12:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 INFO - Cleaning up... 12:39:34 INFO - Return code: 0 12:39:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:34 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:34 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:39:34 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:39:34 INFO - Using env: {'DISPLAY': ':0', 12:39:34 INFO - 'HOME': '/home/cltbld', 12:39:34 INFO - 'LANG': 'en_US.UTF-8', 12:39:34 INFO - 'LANGUAGE': 'en_US:en', 12:39:34 INFO - 'LOGNAME': 'cltbld', 12:39:34 INFO - 'MAIL': '/var/mail/cltbld', 12:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:34 INFO - 'MOZ_NO_REMOTE': '1', 12:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:34 INFO - 'NO_EM_RESTART': '1', 12:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:34 INFO - 'PWD': '/builds/slave/test', 12:39:34 INFO - 'SHELL': '/bin/bash', 12:39:34 INFO - 'SHLVL': '1', 12:39:34 INFO - 'TERM': 'linux', 12:39:34 INFO - 'TMOUT': '86400', 12:39:34 INFO - 'USER': 'cltbld', 12:39:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:34 INFO - '_': '/tools/buildbot/bin/python'} 12:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:34 INFO - Downloading/unpacking jsonschema 12:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:36 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:36 INFO - warning: no files found matching '*.txt' 12:39:36 INFO - no previously-included directories found matching 'build' 12:39:36 INFO - no previously-included directories found matching 'dist' 12:39:36 INFO - no previously-included directories found matching '.git*' 12:39:36 INFO - Installing collected packages: jsonschema, functools32 12:39:36 INFO - Running setup.py install for functools32 12:39:36 INFO - warning: no files found matching '*.txt' 12:39:36 INFO - no previously-included directories found matching 'build' 12:39:36 INFO - no previously-included directories found matching 'dist' 12:39:36 INFO - no previously-included directories found matching '.git*' 12:39:36 INFO - Successfully installed jsonschema functools32 12:39:36 INFO - Cleaning up... 12:39:36 INFO - Return code: 0 12:39:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:39: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:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 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 0x7f5401ac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bee30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', '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:39:36 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:39:36 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:39:36 INFO - Using env: {'DISPLAY': ':0', 12:39:36 INFO - 'HOME': '/home/cltbld', 12:39:36 INFO - 'LANG': 'en_US.UTF-8', 12:39:36 INFO - 'LANGUAGE': 'en_US:en', 12:39:36 INFO - 'LOGNAME': 'cltbld', 12:39:36 INFO - 'MAIL': '/var/mail/cltbld', 12:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:36 INFO - 'MOZ_NO_REMOTE': '1', 12:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:36 INFO - 'NO_EM_RESTART': '1', 12:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:36 INFO - 'PWD': '/builds/slave/test', 12:39:36 INFO - 'SHELL': '/bin/bash', 12:39:36 INFO - 'SHLVL': '1', 12:39:36 INFO - 'TERM': 'linux', 12:39:36 INFO - 'TMOUT': '86400', 12:39:36 INFO - 'USER': 'cltbld', 12:39:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:36 INFO - '_': '/tools/buildbot/bin/python'} 12:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:37 INFO - Downloading/unpacking flake8 12:39:37 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:39:37 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:39:37 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:39:37 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:39:37 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:39:37 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:39:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:39 INFO - no previously-included directories found matching 'docs/_build' 12:39:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:39 INFO - Running setup.py install for pep8 12:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:39 INFO - no previously-included directories found matching 'docs/_build' 12:39:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:39:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:39 INFO - Cleaning up... 12:39:39 INFO - Return code: 0 12:39:39 INFO - Running post-action listener: _resource_record_post_action 12:39:39 INFO - Running post-action listener: _start_resource_monitoring 12:39:39 INFO - Starting resource monitoring. 12:39:39 INFO - ##### 12:39:39 INFO - ##### Running install step. 12:39:39 INFO - ##### 12:39:39 INFO - Running pre-action listener: _resource_record_pre_action 12:39:39 INFO - Running main action method: install 12:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:40 INFO - Reading from file tmpfile_stdout 12:39:40 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:39:40 INFO - Reading from file tmpfile_stdout 12:39:40 INFO - Output received: 12:39:40 INFO - Usage: mozinstall [options] installer 12:39:40 INFO - Options: 12:39:40 INFO - -h, --help show this help message and exit 12:39:40 INFO - -d DEST, --destination=DEST 12:39:40 INFO - Directory to install application into. [default: 12:39:40 INFO - "/builds/slave/test"] 12:39:40 INFO - --app=APP Application being installed. [default: firefox] 12:39:40 INFO - mkdir: /builds/slave/test/build/application 12:39:40 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:39:40 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:39:52 INFO - Reading from file tmpfile_stdout 12:39:52 INFO - Output received: 12:39:52 INFO - /builds/slave/test/build/application/firefox/firefox 12:39:52 INFO - Running post-action listener: _resource_record_post_action 12:39:52 INFO - ##### 12:39:52 INFO - ##### Running run-tests step. 12:39:52 INFO - ##### 12:39:52 INFO - Running pre-action listener: _resource_record_pre_action 12:39:52 INFO - Running main action method: run_tests 12:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:39:52 INFO - Python 2.7.3 12:39:52 INFO - Return code: 0 12:39:52 INFO - grabbing minidump binary from tooltool 12:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351430>, '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 0x12bcf30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bd3c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:39:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:39:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:39:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:53 INFO - Return code: 0 12:39:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:39:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:39:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:39:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:39:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:39:54 INFO - Return code: 0 12:39:54 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/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:39:54 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/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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:39:54 INFO - Using env: {'DISPLAY': ':0', 12:39:54 INFO - 'HOME': '/home/cltbld', 12:39:54 INFO - 'LANG': 'en_US.UTF-8', 12:39:54 INFO - 'LANGUAGE': 'en_US:en', 12:39:54 INFO - 'LOGNAME': 'cltbld', 12:39:54 INFO - 'MAIL': '/var/mail/cltbld', 12:39:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:39:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:54 INFO - 'MOZ_NO_REMOTE': '1', 12:39:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:54 INFO - 'NO_EM_RESTART': '1', 12:39:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:54 INFO - 'PWD': '/builds/slave/test', 12:39:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:39:54 INFO - 'SHELL': '/bin/bash', 12:39:54 INFO - 'SHLVL': '1', 12:39:54 INFO - 'TERM': 'linux', 12:39:54 INFO - 'TMOUT': '86400', 12:39:54 INFO - 'USER': 'cltbld', 12:39:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126', 12:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:54 INFO - '_': '/tools/buildbot/bin/python'} 12:39:54 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/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:39:54 INFO - mozversion application_buildid: 20160311100842 12:39:54 INFO - mozversion application_changeset: 4668361a486d865c53a9ab683563a59b418c350a 12:39:54 INFO - mozversion application_display_name: Firefox 12:39:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:54 INFO - mozversion application_name: Firefox 12:39:54 INFO - mozversion application_remotingname: firefox 12:39:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:39:54 INFO - mozversion application_vendor: Mozilla 12:39:54 INFO - mozversion application_version: 46.0 12:39:54 INFO - mozversion platform_buildid: 20160311100842 12:39:54 INFO - mozversion platform_changeset: 4668361a486d865c53a9ab683563a59b418c350a 12:39:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:39:54 INFO - mozversion platform_version: 46.0 12:39:54 INFO - using testdate: 1457728794 12:39:54 INFO - actual date: 1457728794 12:39:54 INFO - starting webserver on 'localhost:50547' 12:39:54 INFO - SUITE-START | Running 3 tests 12:39:54 INFO - TEST-START | dromaeo_css 12:39:54 INFO - operating with platform_type : linux_ 12:39:54 INFO - Initialising browser for dromaeo_css test... 12:39:54 INFO - TEST-INFO | started process 1032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSww5T2/profile http://localhost:50547/getInfo.html) 12:39:57 INFO - PROCESS | 1032 | __metrics Screen width/height:1600/1200 12:39:57 INFO - PROCESS | 1032 | colorDepth:24 12:39:57 INFO - PROCESS | 1032 | Browser inner width/height: 1024/697 12:39:57 INFO - PROCESS | 1032 | __metrics 12:39:57 INFO - PROCESS | 1032 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:58 INFO - TEST-INFO | 1032: exit 0 12:39:58 INFO - Browser initialized. 12:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:58 INFO - TEST-INFO | started process 1131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSww5T2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:10 INFO - PROCESS | 1131 | RSS: Main: 135323648 12:40:10 INFO - PROCESS | 1131 | 12:41:01 INFO - PROCESS | 1131 | 1457728861243 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:43:09 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50547/tests/dromaeo/cssquery-ext.html) 12:43:10 INFO - PROCESS | 1131 | RSS: Main: 215166976 12:43:10 INFO - PROCESS | 1131 | 12:46:12 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-ext.html (next: http://localhost:50547/tests/dromaeo/cssquery-jquery.html) 12:46:13 INFO - PROCESS | 1131 | RSS: Main: 220135424 12:46:13 INFO - PROCESS | 1131 | 12:49:14 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50547/tests/dromaeo/cssquery-mootools.html) 12:49:15 INFO - PROCESS | 1131 | RSS: Main: 221020160 12:49:15 INFO - PROCESS | 1131 | 12:52:17 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50547/tests/dromaeo/cssquery-prototype.html) 12:52:17 INFO - PROCESS | 1131 | RSS: Main: 207835136 12:52:17 INFO - PROCESS | 1131 | 12:55:20 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50547/tests/dromaeo/cssquery-yui.html) 12:55:20 INFO - PROCESS | 1131 | RSS: Main: 201977856 12:55:20 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-yui.html (next: http://localhost:50547/tests/dromaeo/cssquery-dojo.html) 12:58:23 INFO - PROCESS | 1131 | RSS: Main: 247648256 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | __start_tp_report 12:58:23 INFO - PROCESS | 1131 | _x_x_mozilla_page_load 12:58:23 INFO - PROCESS | 1131 | _x_x_mozilla_page_load_details 12:58:23 INFO - PROCESS | 1131 | |i|pagename|runs| 12:58:23 INFO - PROCESS | 1131 | |0;dojo.html;3249.496328069149;3283.310504793993;3301.3232287381074;3309.8014119152854;3310.8013519188867;5289.180177072551;5301.2313214583955;5303.575713942885;5307.230451584518;5339.038972984861;5325.653832500894;5326.627136100475;5332.306800115989;5363.517283444489;5363.865903352418;4799.616030717551;4887.853364399056;4892.975535122319;4924.162892308298;4926.261060840885;4882.316475693406;4936.950630493703;4941.950580494203;4944.802207911697;4949.851504454854;4905.82829600964;4917.926231106536;4934.40787105546;4935.358403407552;4937.80248790048;4971.154903666367;5014.222795466709;5050.141475949061;5054.873628159326;5055.140626093536;4973.055119527278;5000.924986125211;5013.298138260647;5015.84952451427;5047.217681259411;5144.691318520863;5155;5227.2159176123505;5228.215767634847;5314.548263397616;5806.65160090396;5842.707864606753;5842.853928651775;5852.385499522531;5866.442687944638;5881.441263080001;5883.470487656089;5900.881982360372;5906.970465147647;5907.438793314628;5216.400113986902;5308.23030660552;5429.185622156708;5479.698616576126;5595.356533998561;5833.88332233353;5839.211706419664;5840.795572155039;5847.912281315784;5850.678212698257;5613.354464236583;5627.212190293362;5629.352624448159;5636.126400407943;5636.436356364413;5610.775568977277;5703.971480142655;5751.424857514216;5829.358770535237;5856.795012174553;5779.450952159538;5788.739506722208;5789.507891829242;5794.420557944172;5828.59199856006;5619.381867994517;5761.193432919395;5799.652020878676;5802.390748971297;5812.94187058124;4355.1507456045765;4382.342648602735;4390.648748100144;4399.428074350314;4422.469303683579;3947.0921688011344;3954.940675889864;3964.861229856941;3984.86052988144;3988.700847436454;5344.786208551692;5415.241866138744;5416.7020813855615;5428.782848686008;5453.836384908459;5822.301323841166;5865.765369385177;5882.617629854046;5913.852153696192;5945.227120474311;5460.535854452337;5517.834464966058;5531.3362396512675;5539.861503462445;5550.250716153349;4854.660173787872;4943.060818444484;4973;5018.2974383586325;5056.696598204119;5994.6403215807195;5998.9100163496705;6000.879982400327;6007.249093863267;6011.5190784737115;5817.981853175593;5828.679422631796;5834.329052158886;5840.474357307693;5848.152017957457;5727.312722473163;5836.912446313224;5924.407559244213;5968.940310596839;6034.155218269533;5758.452946970031;5759.164921086335;5760.798372056958;5762.1068734346245;5769;5805.361410244954;5825.912611310749;5859.44335288147;5862.296524417097;5867.383924687846;5546.306711661043;5582.190582365453;5621.4659607337235;5684.289463817023;5720.02759530889;5718.714064296852;5730.541556675373;5734.111212762028;5735.71321433935;5737.368889422077;5380.892382152257;5640.943590564206;5647.1529270609735;5649.350324712711;5658.632188907708;5589.357223919302;5700.344460386943;5744.942550574441;5763.9135412968;5800.8259752207505;5616.522595579421;5646.548276137817;5662.886742265214;5664.745086471201;5668.461496157858 12:58:23 INFO - PROCESS | 1131 | |1;ext.html;542.9049916264653;560.963537370071;561.068626080706;566.19882865745;581.8399940016492;29996.700032999663;30476.39047219057;38066.80966595167;38345.42481862774;38437.615623843754;42379.57620423795;42819.14361712764;42864.57135428645;42913.356299655454;42932.14135717291;8760.8685869712;8958.417702849294;8971.05803890592;8972.775680607972;8973.596188171548;8576.05663377028;8715.607797649089;8720.258778003878;8721.95639021804;8724.52015139167;8945.239654629364;9026.23277021454;9026.368154229207;9029.097090290985;9031.277497800193;8898.065703101178;8901.465912045232;8964.103589641049;8980.416272942239;8982.550872456384;8875.556222188865;8907.064758200426;8936.195742383152;9018.053104424072;9023.593938272794;42200;42546;42674.57325426737;42682.78658606718;42691.14617707628;3384.8984530464127;3386.1196089016785;3479.7216222702377;3675.467057276707;3758.3047136279874;30795;32292.838535807405;32417.35165296681;32440;33145.33709325824;4087.1825634873144;4137.420761093449;4185.22573323936;4227.1524688116115;4272.530021697611;292086;293782;294369;294619;300672;61362.69318653468;62476;62608.37391626026;62779;62840.68579657164;57008.714956425785;57078.7146064267;57087.714561427754;57241;57278.7136064317;14671;14793.852061479463;14804.18576978255;14810.111393316436;14814.481493147689;9836.655717050013;9842.557084931195;9872.802543949081;9936.850947235796;10059.144972677404;20135.697964530544;20483.69274460884;20495.18019279242;20509.17963281482;20519.4870128248;7551.186650741451;7888.092869320101;7915.841683166304;7916.960415198002;7940.722074727357;1046.1787496814964;1066.7013236293851;1079.3847506921136;1171.5840876488894;1219.5975328141692;29706.257343566584;30180.84909575438;30860.22849428782;31094.53358199629;31161;1100.9174311926638;1129.615930583589;1141.7944769941323;1156.3582211872492;1298.6623477895625;13164.802527962089;13728.382222799997;13852.991316259287;14004.089734167246;14957.70084598302;356027;366812;367126;367466;367886;53738.731306343216;54036.459635403146;54056.459435405144;54094.64763380947;54147.729261353445;1296.6434230586476;1373.3133433283358;1387.9722405551831;1458.9489367872075;1474.3954978458994;25582.744172558036;25701.87149064243;27579.72420275852;27749.86125069362;28289.71710282871;43573;43750.78124609357;43775.56224437715;43822.34266486069;43963.78018109889;231234;232716;233546;234340;234884;32297;32643.836780815946;32766.34467310688;32968;33130.337393252485;43266.783666081465;44299.55700443083;44459.110157839634;44529;44940.775296124615;36756.44865327076;37125.814370927976;37712.24575508529;37726.245475089796;38674.6132538671;36583.63416365909;37217.25565488621;37779.81110094432;38122.237555249296;38394.80802595969;37896.43155352617;38021.42967855429;38162.80918595389;38286.42570361391;38307;31221.375572488876;31662;32003.519947201275;32146.678533215305;32249.677503225605;33846.492302615974;33969.66030339665;34139.65860341365;34195.658043419244;34236.31527369488 12:58:23 INFO - PROCESS | 1131 | |2;jquery.html;373.05616789522503;380.68022860796935;382.2736800079848;382.88322061771146;383.1188266985932;14251.50119745809;15461.5361539154;15830.76253856193;17821.10894455277;17963.640727185466;16640.916795416008;16731.83268167318;16983.91508042458;17901.373451929187;17904.104794760242;4151.937720934188;5472.890542189154;5676.971615141919;5679.318481782171;5682.119271512922;4285.978570107145;5841.620294680833;6035.094735789623;6036.913355595991;6038.51691864652;5829.271341082364;5955.1960485334575;6114.633122012693;6117.113018612298;6120.387961203888;5885.352611212763;6021.217241758565;6041.667708276043;6070.878582428349;6186.288576813679;5432.782688692487;5473.616846820724;5474.233607294982;5474.616776825624;5475.780968761244;20156.193752249892;20401.5919681607;20409.795902041085;20582.897085514476;20796.58406831855;2357.422431504275;2371.679823223877;2375.8930848111704;2443.1082654830857;2468.790152837011;9386.108319709616;9636.566354514063;13021.934890325583;13200.73598528024;13326;1742.1028170492207;1759.876808623397;1807.8734488585803;1869.5045812859603;1871.167330537911;56351.71824140853;56386.15420768733;56644.15033774497;56758.43241567573;58312.70843645797;10743.731406714738;10836.133109351233;10876.510557024953;10894.564217431373;10960.12319014477;14281.071730337495;14304.356303966346;14420.495282665057;14421;14426.783598246035;7620.085589729268;7650.502717323357;7713.884291735629;7716.845663086707;7738.845223095506;6807.115075040213;6872;6876.656167191621;6884.173899132136;7041;4284.335927931175;4494.977525112354;4497.325401189848;4695.483496815347;4769.165396055676;1726.180064469367;1758.384565402099;1822.8723989320886;1874.9718754218698;1880.3230836898706;894.8165626046645;917.9541022948825;962.0475729028211;1008.7881544875659;1034.9340179615008;16659.750103748454;16936.915315423343;17590.2084406202;17833.375831845824;18307.35924242645;994.4480813148627;1010.2625083688948;1029.9742506437399;1031.783325501653;1038.117600039975;9902.752431189134;10064.647737329306;10709.410982396043;10712.143028557697;10732.73168170802;543857;568629;570177;582948;619138;76180.61909690416;76634.6168269155;76735.61632191803;78741;79200;1250.493550112206;1252.8997680185564;1255.0461649146532;1257.6038547857395;1277.2464246094848;15776.447824326093;15837.524874253791;15893.761593575875;16027;16155.27301271422;35468.290634186655;35825.64174358223;36236.81881590681;36358;36620.26759464849;44619.33071004003;45227.54772452233;46131.76934115308;47196.7640161797;47311;7635.618219088912;7870.094939082079;7936.484128531627;7962.601869906597;8052.476589021695;4630.795993041901;9923.950380248052;10146;11668.358240296866;12006.63980080599;9515.191208747057;9596.18432433251;9759.268054895769;9789;10034.19726421899;10039.196864250696;10187.439690817077;10498.842517362093;10543.894561054598;10707.840983093218;9012.098790120936;9373.718788436357;9442.905570944478;9487.66793162236;9577.185939195246;7713.575753333621;7756.3019328260725;7764.92235077642;7785.416093793101;7808;7125.572465652078;9435.481048542397;9500.762480937756;9734.41593504392;9967.800643987224 12:58:23 INFO - PROCESS | 1131 | |3;mootools.html;1539.3534715419523;1550.9224538773058;1736.5571779196302;1843.6865732825418;1851.9259229630807;8015.519068855872;8149.4702844315225;8184.672613095477;8204.753857384288;8234.17658234177;7078.964605176967;7230.349268565828;7690.500117492359;7747.767566973;7896.052473703164;2410.6745589345433;2420.6369044643357;2445.327534927891;2450.546648869956;2451.3626457121186;2046.130394582304;2400.6879105716234;2431.3192306154215;2439.560879041772;2446.926592202237;2126.9361919142375;2380.059876348841;2433.3916520869784;2435.768601982809;2435.9878200608973;2391.4858305464236;2408.2895545814026;2437.2688193541867;2447.363685441789;2450.4363996280867;2389.7371289158177;2430.769076937688;2442.0842184180933;2446.8409553378974;2446.9143579974616;7845.490043147177;7846.372290216769;7862.488938218998;7893.881591776128;8094.3524518039;5024.748762561857;5075.111855425286;5088.949110508885;5137.922931156036;5148.9485105149215;3130.6869313068737;3138.717515423623;3166.667499912522;3213.8714451421915;3240.3843269778904;993.4883534979491;1000.929934904557;1013.4780587997187;1023;1040.7554224757175;11327.943360283229;11615.070794336432;11637.301761894229;11644.126690498246;11644.650660480114;4531.161735079021;4584.587387135174;4661.440627124699;4686.226772582554;4691.7654117294;9813.754656133511;9831.213502919749;9836.60653573849;9849.60601575929;9856.901430985741;5206.401263854629;5212.765425555859;5213.661112027706;5217.3999990000875;5223.738813059332;4621.376114224604;4684.578387945101;4685.718856868531;4690.835820746258;4692.131955588227;3828.9617103829164;3839.251345987506;3874.2638898609175;3875.399313106473;3913.7064720146104;1208.7763763703742;1223.5350566784564;1229.6188181663713;1237.1216436330305;1238.504598160743;1157.8147496400536;1158.7392836611696;1179.4928180882303;1182.018924292835;1259.3703148425786;7714.074311082706;7794.688212471551;7795.610219489116;7836.882446763303;7944.6027698614835;1160.640201537526;1185.466540056978;1190.3691043746828;1190.9940450297865;1191.0828661930266;5884.9705751470965;5910.645361278337;5939.970300148471;5945.10823376497;5968.910466343008;9131.406458580172;9825.312228144105;9829.55766990487;9855.55649995752;9934.950325248328;9656.468894210746;9657.420554766595;9757.073078057572;10099.7475063124;10152.340097893613;7406.777796666109;7762.262585054524;7800.024996875391;7864.449488535747;7872.44892857506;7629.580373079534;7666.501677390952;7680.692772289046;7694.769156925301;7716.691332346643;8625.223729864343;8962.910370896469;9007.05425930294;9018.909810901807;9050.864237036318;9036.23192028685;9057.728268151966;9148.862767058632;9244.676436324697;9318;7059.647017649199;7167.49482608658;7171.748988785367;7198.820029499305;7208.423326134001;7908.209179082046;7914.24814642608;7931.36549076061;8007.079185893696;8065.9596702016115;6832.077669514552;7537.397008239437;7607.923920760722;7702.922970770444;7740.7677769667;6880.2431732508385;7288.12542494904;7291.708331666674;7392.371648409945;7430.851382972202;7502.549847008979;7608.467407281437;7615.619219039137;7617.047869016373;7623.733169339268;6826.249112597511;6973.407260382722;6993.790186294419;6994.475414343843;7002.7899163025195;6789.083473731181;6876.381125698711;6890.44876409896;6890.689918953759;6890.758823441356 12:58:23 INFO - PROCESS | 1131 | |4;prototype.html;354.4576797499826;361.6275236506398;363.1913072896973;368.38847513128206;371.3649659082969;6049.939500604998;6058.424449677279;6076.908846367308;6079.179310793042;6089.634621922688;5704.11586204139;5838.766449342032;5870.61840980336;6003.909941350883;6015.127806468059;4706.458757242909;4712.764361781914;4724.551167639086;4725.432948046239;4745.715257084568;4495.685302028859;4718.764061796914;4733.195356789354;4734.621230301585;4745.92881106782;4552.9089418211615;4557.225271703802;4628.30575413689;4672.6729128960815;4693.436787585494;4661.067786442725;4664.55686709762;4669.066186762627;4689.320048592969;4691.3432119503295;4165.97917010416;4172.749635021908;4174.102567947875;4174.3947127666315;4178.6657067434535;5596.860078498029;5759.164921086419;5763.625364351304;5774.913376299359;5776.249087618583;5303.071962406563;5303.761330740126;5307.628466007381;5310.57515398771;5315.255864179018;6405.29541750407;6433.8391540211405;6434.356564343575;6441.645709485976;6510.707018184193;4460.041091165415;4463.933041004388;4465.263231566788;4466.12910482456;4469.1732029574305;6555.901661475082;6600.273969863311;6672.799816005528;6675.46596272297;6682.231543372526;4586.541345865454;4601.700889442175;4602.930956035662;4603.286490593963;4615;4670.112678591125;4675.555822196886;4676.181668208118;4678.087772884323;4682.695624784378;5358.410574836765;5366.570674346121;5377.919331210035;5382.381026181961;5383.946160538423;6288.308286088527;6439.22729272481;6443.5167362448;6455.7740479083;6464.321246269168;1623.9431619893483;1631.4208455998187;1631.616570106024;1632.6000129968234;1634.2645809385824;1092.9617463388743;1103.1836441033577;1105.5798796457295;1124.5052177042076;1124.7571433565793;6202.131701561785;6207.34822843604;6212.875742485125;6213.285472170668;6220.222472190976;6397.840053998687;6634.834129146713;6638.070670106189;6646.567973081831;6650.068990341356;6121.938780612226;6129.816105516842;6282.057691346335;6282.2147231596055;6283.371662833772;3567.126054116706;3598.3522965865873;3601.9099522511624;3601.94597081044;3607.3867442534834;6658.167729033871;6707.3628005339415;6797.898031529531;6832.419244364185;6834.077399550997;6853.485988550879;6866;6881.793546193622;6883.208431030395;6885.793426197222;6830.112085428962;6843;6849.075374824434;6854.451643868479;6857.622830744257;6538.574992625464;6684.899726504009;6690.163729533809;6695.096162018065;6704.262531121671;6562.245341785565;6573.211214654272;6576.145101136822;6580.045893345534;6580.440662543738;6815.693293801692;6822.965885170543;6825.839607266677;6827.795166145023;6828.385445309946;4587.243104887656;4655.255159174516;4664.323673067318;4665;4668.78990445424;6665.833354166185;6688.130543029375;6692.564983276072;6693.598384096969;6694.230163531061;6441.838954026187;6493;6521.152250207632;6556.409923106943;6560.704768285344;6387.137736405712;6464.22429308486;6481.740730370732;6486.708098135501;6496.545241833026;6277.623342599459;6329.588576742497;6329.841753956004;6332.746690132343;6393.104965304954;6527.3472652734345;6583;6583.144191255106;6584.473242140713;6607.669616519251;6136.325004249618;6359.87280254383;6368.872622547616;6370.840728981812;6371.5221358397375 12:58:23 INFO - PROCESS | 1131 | |5;yui.html;914.6935776514867;922.2575826459706;925.421611492817;926.7451450851015;938.2400255792807;13724.451021959123;14128.011039227258;14146.434142634294;14160.57518274451;14167.504137355194;13418.530351437701;13477.326133693325;13498;13509.18944863309;13514.72970540591;709.2588245283665;719.5466855880787;876.0101085773099;879.8152387998496;895.3285036222849;824.9422540422173;882.1046637662778;899.622158693347;900.4147304252223;900.8693739407782;925.7315378540216;926.2451102351596;928.067292371166;928.4336554701626;928.749237705819;752.1763668782702;763.6487215880702;912.1608120529129;922.3267015078997;932.1098351074708;675.9391654751047;677.7898851356047;678.6335378895391;682.5290549520814;683.2791405067652;13710.794338084937;13740.725185496334;13755;13776.897848172122;13778;12744.235345879184;13333.134242184396;13455.529056483074;13455.798163027563;13490;10759.569617215302;10935.234533582652;11023.44882755859;11059.22585419021;11194.04850587701;3843.500344955166;3845.8653947111998;3849.095462566295;3872;3874.670652994499;48938.26592601114;49382.25926611104;49833;49910;50198.24702629464;10419.166466682647;10466.372017678963;10538.367697938149;10551.736206594896;10640.627578034731;19635.803641963397;19757.506062348555;19760.70358944617;19801.504962376057;19838.70241946372;7720.112187098443;7771.222877712184;7863.0957439894;7913.762587122281;8071.031476222891;4332.740035597874;4489.483709373399;4559.38448309474;4602.4477062752685;4603.838865639686;3304.4052070627517;3333.6499667535045;3335.832458639457;3337.1156643489494;3350.7654464187763;565.1776664952484;580.7386675995734;582.4437662032749;586.7359688140353;596.1058412381428;687.4637782529635;706.2901783707341;711.7402148215864;712.5617745086838;717.5551158281794;8559.871601925975;9169.95415022934;9265.675701350421;9308.115729005734;9844.60621575129;542.481929757081;542.956563474929;548.1749966300692;586.489753914089;685.1093578348127;4188.518320393194;4253.447051883235;4255.97872010638;4357.237483440449;4359.498657654347;58550;58963.705181473815;59249.40750592439;59805.700971494865;59854.40145598575;48582.51417485851;55015.724921375135;55865;56000;56020.71989640026;47282.29076563854;47647;48475.75762121167;48643;49491.25763113484;9437.905620943702;9486.857697134687;9660.130588247092;9778.462184579916;9814.312998090065;33355.332893342485;33797.83101084577;34302.14244643904;34461.65538344685;34586.30827383488;42621.786891066586;42937.35593966155;46506.767466162455;46620.53379466162;47218;12108.939455302667;12154.453049612965;12249.326287054297;12451.25292482454;12530.561430349893;12514.687132821753;12528;12748.74502509926;12774.36128193568;13418.261995590336;12256.264624122581;12280.508779648713;12763.170393924365;13038.934805325913;13039.674008149872;12479.93760031194;12698.873011269769;12735.55425560101;12770.42533086032;12853.100282980102;10403.167746580104;11531.481083351102;11866.228695134789;12200;12782.105252632227;9844.310898237054;9848.359856609297;9977.60089596408;10149.847752283575;10189.54147063369;9682.080202380763;9717.951410242904;9793.265505087005;10014.94992525062;10062.295639305179 12:58:23 INFO - PROCESS | 1131 | __end_tp_report 12:58:23 INFO - PROCESS | 1131 | __start_cc_report 12:58:23 INFO - PROCESS | 1131 | _x_x_mozilla_cycle_collect,749 12:58:23 INFO - PROCESS | 1131 | __end_cc_report 12:58:23 INFO - PROCESS | 1131 | __startTimestamp1457729903302__endTimestamp 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | ------- Summary: start ------- 12:58:23 INFO - PROCESS | 1131 | Number of tests: 6 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#0] dojo.html Cycles:165 Average:5384.06 Median:5619.38 stddev:596.43 (10.6%) stddev-sans-first:574.27 12:58:23 INFO - PROCESS | 1131 | Values: 3249.5 3283.3 3301.3 3309.8 3310.8 5289.2 5301.2 5303.6 5307.2 5339.0 5325.7 5326.6 5332.3 5363.5 5363.9 4799.6 4887.9 4893.0 4924.2 4926.3 4882.3 4937.0 4942.0 4944.8 4949.9 4905.8 4917.9 4934.4 4935.4 4937.8 4971.2 5014.2 5050.1 5054.9 5055.1 4973.1 5000.9 5013.3 5015.8 5047.2 5144.7 5155.0 5227.2 5228.2 5314.5 5806.7 5842.7 5842.9 5852.4 5866.4 5881.4 5883.5 5900.9 5907.0 5907.4 5216.4 5308.2 5429.2 5479.7 5595.4 5833.9 5839.2 5840.8 5847.9 5850.7 5613.4 5627.2 5629.4 5636.1 5636.4 5610.8 5704.0 5751.4 5829.4 5856.8 5779.5 5788.7 5789.5 5794.4 5828.6 5619.4 5761.2 5799.7 5802.4 5812.9 4355.2 4382.3 4390.6 4399.4 4422.5 3947.1 3954.9 3964.9 3984.9 3988.7 5344.8 5415.2 5416.7 5428.8 5453.8 5822.3 5865.8 5882.6 5913.9 5945.2 5460.5 5517.8 5531.3 5539.9 5550.3 4854.7 4943.1 4973.0 5018.3 5056.7 5994.6 5998.9 6000.9 6007.2 6011.5 5818.0 5828.7 5834.3 5840.5 5848.2 5727.3 5836.9 5924.4 5968.9 6034.2 5758.5 5759.2 5760.8 5762.1 5769.0 5805.4 5825.9 5859.4 5862.3 5867.4 5546.3 5582.2 5621.5 5684.3 5720.0 5718.7 5730.5 5734.1 5735.7 5737.4 5380.9 5640.9 5647.2 5649.4 5658.6 5589.4 5700.3 5744.9 5763.9 5800.8 5616.5 5646.5 5662.9 5664.7 5668.5 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#1] ext.html Cycles:180 Average:47244.47 Median:37958.93 stddev:79275.60 (208.8%) stddev-sans-first:79420.44 12:58:23 INFO - PROCESS | 1131 | Values: 542.9 561.0 561.1 566.2 581.8 29996.7 30476.4 38066.8 38345.4 38437.6 42379.6 42819.1 42864.6 42913.4 42932.1 8760.9 8958.4 8971.1 8972.8 8973.6 8576.1 8715.6 8720.3 8722.0 8724.5 8945.2 9026.2 9026.4 9029.1 9031.3 8898.1 8901.5 8964.1 8980.4 8982.6 8875.6 8907.1 8936.2 9018.1 9023.6 42200.0 42546.0 42674.6 42682.8 42691.1 3384.9 3386.1 3479.7 3675.5 3758.3 30795.0 32292.8 32417.4 32440.0 33145.3 4087.2 4137.4 4185.2 4227.2 4272.5 292086.0 293782.0 294369.0 294619.0 300672.0 61362.7 62476.0 62608.4 62779.0 62840.7 57008.7 57078.7 57087.7 57241.0 57278.7 14671.0 14793.9 14804.2 14810.1 14814.5 9836.7 9842.6 9872.8 9936.9 10059.1 20135.7 20483.7 20495.2 20509.2 20519.5 7551.2 7888.1 7915.8 7917.0 7940.7 1046.2 1066.7 1079.4 1171.6 1219.6 29706.3 30180.8 30860.2 31094.5 31161.0 1100.9 1129.6 1141.8 1156.4 1298.7 13164.8 13728.4 13853.0 14004.1 14957.7 356027.0 366812.0 367126.0 367466.0 367886.0 53738.7 54036.5 54056.5 54094.6 54147.7 1296.6 1373.3 1388.0 1458.9 1474.4 25582.7 25701.9 27579.7 27749.9 28289.7 43573.0 43750.8 43775.6 43822.3 43963.8 231234.0 232716.0 233546.0 234340.0 234884.0 32297.0 32643.8 32766.3 32968.0 33130.3 43266.8 44299.6 44459.1 44529.0 44940.8 36756.4 37125.8 37712.2 37726.2 38674.6 36583.6 37217.3 37779.8 38122.2 38394.8 37896.4 38021.4 38162.8 38286.4 38307.0 31221.4 31662.0 32003.5 32146.7 32249.7 33846.5 33969.7 34139.7 34195.7 34236.3 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#2] jquery.html Cycles:180 Average:29154.88 Median:24557.15 stddev:94332.82 (384.1%) stddev-sans-first:94572.68 12:58:23 INFO - PROCESS | 1131 | Values: 373.1 380.7 382.3 382.9 383.1 14251.5 15461.5 15830.8 17821.1 17963.6 16640.9 16731.8 16983.9 17901.4 17904.1 4151.9 5472.9 5677.0 5679.3 5682.1 4286.0 5841.6 6035.1 6036.9 6038.5 5829.3 5955.2 6114.6 6117.1 6120.4 5885.4 6021.2 6041.7 6070.9 6186.3 5432.8 5473.6 5474.2 5474.6 5475.8 20156.2 20401.6 20409.8 20582.9 20796.6 2357.4 2371.7 2375.9 2443.1 2468.8 9386.1 9636.6 13021.9 13200.7 13326.0 1742.1 1759.9 1807.9 1869.5 1871.2 56351.7 56386.2 56644.2 56758.4 58312.7 10743.7 10836.1 10876.5 10894.6 10960.1 14281.1 14304.4 14420.5 14421.0 14426.8 7620.1 7650.5 7713.9 7716.8 7738.8 6807.1 6872.0 6876.7 6884.2 7041.0 4284.3 4495.0 4497.3 4695.5 4769.2 1726.2 1758.4 1822.9 1875.0 1880.3 894.8 918.0 962.0 1008.8 1034.9 16659.8 16936.9 17590.2 17833.4 18307.4 994.4 1010.3 1030.0 1031.8 1038.1 9902.8 10064.6 10709.4 10712.1 10732.7 543857.0 568629.0 570177.0 582948.0 619138.0 76180.6 76634.6 76735.6 78741.0 79200.0 1250.5 1252.9 1255.0 1257.6 1277.2 15776.4 15837.5 15893.8 16027.0 16155.3 35468.3 35825.6 36236.8 36358.0 36620.3 44619.3 45227.5 46131.8 47196.8 47311.0 7635.6 7870.1 7936.5 7962.6 8052.5 4630.8 9924.0 10146.0 11668.4 12006.6 9515.2 9596.2 9759.3 9789.0 10034.2 10039.2 10187.4 10498.8 10543.9 10707.8 9012.1 9373.7 9442.9 9487.7 9577.2 7713.6 7756.3 7764.9 7785.4 7808.0 7125.6 9435.5 9500.8 9734.4 9967.8 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#3] mootools.html Cycles:180 Average:5781.11 Median:6379.00 stddev:2988.48 (46.8%) stddev-sans-first:2979.85 12:58:23 INFO - PROCESS | 1131 | Values: 1539.4 1550.9 1736.6 1843.7 1851.9 8015.5 8149.5 8184.7 8204.8 8234.2 7079.0 7230.3 7690.5 7747.8 7896.1 2410.7 2420.6 2445.3 2450.5 2451.4 2046.1 2400.7 2431.3 2439.6 2446.9 2126.9 2380.1 2433.4 2435.8 2436.0 2391.5 2408.3 2437.3 2447.4 2450.4 2389.7 2430.8 2442.1 2446.8 2446.9 7845.5 7846.4 7862.5 7893.9 8094.4 5024.7 5075.1 5088.9 5137.9 5148.9 3130.7 3138.7 3166.7 3213.9 3240.4 993.5 1000.9 1013.5 1023.0 1040.8 11327.9 11615.1 11637.3 11644.1 11644.7 4531.2 4584.6 4661.4 4686.2 4691.8 9813.8 9831.2 9836.6 9849.6 9856.9 5206.4 5212.8 5213.7 5217.4 5223.7 4621.4 4684.6 4685.7 4690.8 4692.1 3829.0 3839.3 3874.3 3875.4 3913.7 1208.8 1223.5 1229.6 1237.1 1238.5 1157.8 1158.7 1179.5 1182.0 1259.4 7714.1 7794.7 7795.6 7836.9 7944.6 1160.6 1185.5 1190.4 1191.0 1191.1 5885.0 5910.6 5940.0 5945.1 5968.9 9131.4 9825.3 9829.6 9855.6 9935.0 9656.5 9657.4 9757.1 10099.7 10152.3 7406.8 7762.3 7800.0 7864.4 7872.4 7629.6 7666.5 7680.7 7694.8 7716.7 8625.2 8962.9 9007.1 9018.9 9050.9 9036.2 9057.7 9148.9 9244.7 9318.0 7059.6 7167.5 7171.7 7198.8 7208.4 7908.2 7914.2 7931.4 8007.1 8066.0 6832.1 7537.4 7607.9 7702.9 7740.8 6880.2 7288.1 7291.7 7392.4 7430.9 7502.5 7608.5 7615.6 7617.0 7623.7 6826.2 6973.4 6993.8 6994.5 7002.8 6789.1 6876.4 6890.4 6890.7 6890.8 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#4] prototype.html Cycles:180 Average:5397.56 Median:6125.88 stddev:1611.80 (26.3%) stddev-sans-first:1571.25 12:58:23 INFO - PROCESS | 1131 | Values: 354.5 361.6 363.2 368.4 371.4 6049.9 6058.4 6076.9 6079.2 6089.6 5704.1 5838.8 5870.6 6003.9 6015.1 4706.5 4712.8 4724.6 4725.4 4745.7 4495.7 4718.8 4733.2 4734.6 4745.9 4552.9 4557.2 4628.3 4672.7 4693.4 4661.1 4664.6 4669.1 4689.3 4691.3 4166.0 4172.7 4174.1 4174.4 4178.7 5596.9 5759.2 5763.6 5774.9 5776.2 5303.1 5303.8 5307.6 5310.6 5315.3 6405.3 6433.8 6434.4 6441.6 6510.7 4460.0 4463.9 4465.3 4466.1 4469.2 6555.9 6600.3 6672.8 6675.5 6682.2 4586.5 4601.7 4602.9 4603.3 4615.0 4670.1 4675.6 4676.2 4678.1 4682.7 5358.4 5366.6 5377.9 5382.4 5383.9 6288.3 6439.2 6443.5 6455.8 6464.3 1623.9 1631.4 1631.6 1632.6 1634.3 1093.0 1103.2 1105.6 1124.5 1124.8 6202.1 6207.3 6212.9 6213.3 6220.2 6397.8 6634.8 6638.1 6646.6 6650.1 6121.9 6129.8 6282.1 6282.2 6283.4 3567.1 3598.4 3601.9 3601.9 3607.4 6658.2 6707.4 6797.9 6832.4 6834.1 6853.5 6866.0 6881.8 6883.2 6885.8 6830.1 6843.0 6849.1 6854.5 6857.6 6538.6 6684.9 6690.2 6695.1 6704.3 6562.2 6573.2 6576.1 6580.0 6580.4 6815.7 6823.0 6825.8 6827.8 6828.4 4587.2 4655.3 4664.3 4665.0 4668.8 6665.8 6688.1 6692.6 6693.6 6694.2 6441.8 6493.0 6521.2 6556.4 6560.7 6387.1 6464.2 6481.7 6486.7 6496.5 6277.6 6329.6 6329.8 6332.7 6393.1 6527.3 6583.0 6583.1 6584.5 6607.7 6136.3 6359.9 6368.9 6370.8 6371.5 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - PROCESS | 1131 | [#5] yui.html Cycles:180 Average:14401.89 Median:25555.30 stddev:16430.12 (64.3%) stddev-sans-first:16444.99 12:58:23 INFO - PROCESS | 1131 | Values: 914.7 922.3 925.4 926.7 938.2 13724.5 14128.0 14146.4 14160.6 14167.5 13418.5 13477.3 13498.0 13509.2 13514.7 709.3 719.5 876.0 879.8 895.3 824.9 882.1 899.6 900.4 900.9 925.7 926.2 928.1 928.4 928.7 752.2 763.6 912.2 922.3 932.1 675.9 677.8 678.6 682.5 683.3 13710.8 13740.7 13755.0 13776.9 13778.0 12744.2 13333.1 13455.5 13455.8 13490.0 10759.6 10935.2 11023.4 11059.2 11194.0 3843.5 3845.9 3849.1 3872.0 3874.7 48938.3 49382.3 49833.0 49910.0 50198.2 10419.2 10466.4 10538.4 10551.7 10640.6 19635.8 19757.5 19760.7 19801.5 19838.7 7720.1 7771.2 7863.1 7913.8 8071.0 4332.7 4489.5 4559.4 4602.4 4603.8 3304.4 3333.6 3335.8 3337.1 3350.8 565.2 580.7 582.4 586.7 596.1 687.5 706.3 711.7 712.6 717.6 8559.9 9170.0 9265.7 9308.1 9844.6 542.5 543.0 548.2 586.5 685.1 4188.5 4253.4 4256.0 4357.2 4359.5 58550.0 58963.7 59249.4 59805.7 59854.4 48582.5 55015.7 55865.0 56000.0 56020.7 47282.3 47647.0 48475.8 48643.0 49491.3 9437.9 9486.9 9660.1 9778.5 9814.3 33355.3 33797.8 34302.1 34461.7 34586.3 42621.8 42937.4 46506.8 46620.5 47218.0 12108.9 12154.5 12249.3 12451.3 12530.6 12514.7 12528.0 12748.7 12774.4 13418.3 12256.3 12280.5 12763.2 13038.9 13039.7 12479.9 12698.9 12735.6 12770.4 12853.1 10403.2 11531.5 11866.2 12200.0 12782.1 9844.3 9848.4 9977.6 10149.8 10189.5 9682.1 9718.0 9793.3 10014.9 10062.3 12:58:23 INFO - PROCESS | 1131 | -------- Summary: end -------- 12:58:23 INFO - PROCESS | 1131 | 12:58:23 INFO - TEST-INFO | 1131: exit 0 12:58:23 INFO - TEST-OK | dromaeo_css | took 1109622ms 12:58:23 INFO - TEST-START | kraken 12:58:23 INFO - operating with platform_type : linux_ 12:58:23 INFO - Initialising browser for kraken test... 12:58:23 INFO - TEST-INFO | started process 1402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJrG7p/profile http://localhost:50547/getInfo.html) 12:58:27 INFO - PROCESS | 1402 | __metrics Screen width/height:1600/1200 12:58:27 INFO - PROCESS | 1402 | colorDepth:24 12:58:27 INFO - PROCESS | 1402 | Browser inner width/height: 1024/697 12:58:27 INFO - PROCESS | 1402 | __metrics 12:58:27 INFO - PROCESS | 1402 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:28 INFO - TEST-INFO | 1402: exit 0 12:58:28 INFO - Browser initialized. 12:58:28 INFO - Running cycle 1/1 for kraken test... 12:58:28 INFO - TEST-INFO | started process 1493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJrG7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:39 INFO - PROCESS | 1493 | RSS: Main: 135671808 12:58:39 INFO - PROCESS | 1493 | 12:58:42 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:42 INFO - PROCESS | 1493 | RSS: Main: 168972288 12:58:42 INFO - PROCESS | 1493 | 12:58:45 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-dft) 12:58:46 INFO - PROCESS | 1493 | RSS: Main: 168714240 12:58:46 INFO - PROCESS | 1493 | 12:58:49 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-fft) 12:58:49 INFO - PROCESS | 1493 | RSS: Main: 165621760 12:58:49 INFO - PROCESS | 1493 | 12:58:51 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-oscillator) 12:58:52 INFO - PROCESS | 1493 | RSS: Main: 165007360 12:58:52 INFO - PROCESS | 1493 | 12:58:54 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:54 INFO - PROCESS | 1493 | RSS: Main: 164581376 12:58:54 INFO - PROCESS | 1493 | 12:58:57 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:58 INFO - PROCESS | 1493 | RSS: Main: 164986880 12:58:58 INFO - PROCESS | 1493 | 12:59:01 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:02 INFO - PROCESS | 1493 | RSS: Main: 165806080 12:59:02 INFO - PROCESS | 1493 | 12:59:05 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50547/tests/kraken/driver.html?testName=json-parse-financial) 12:59:05 INFO - PROCESS | 1493 | RSS: Main: 165814272 12:59:05 INFO - PROCESS | 1493 | 12:59:07 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:07 INFO - PROCESS | 1493 | RSS: Main: 168255488 12:59:07 INFO - PROCESS | 1493 | 12:59:09 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:10 INFO - PROCESS | 1493 | RSS: Main: 166248448 12:59:10 INFO - PROCESS | 1493 | 12:59:12 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:12 INFO - PROCESS | 1493 | RSS: Main: 171638784 12:59:12 INFO - PROCESS | 1493 | 12:59:14 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:15 INFO - PROCESS | 1493 | RSS: Main: 175976448 12:59:15 INFO - PROCESS | 1493 | 12:59:17 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:18 INFO - PROCESS | 1493 | RSS: Main: 172220416 12:59:18 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50547/tests/kraken/driver.html?testName=ai-astar) 12:59:20 INFO - PROCESS | 1493 | RSS: Main: 233177088 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | __start_tp_report 12:59:20 INFO - PROCESS | 1493 | _x_x_mozilla_page_load 12:59:20 INFO - PROCESS | 1493 | _x_x_mozilla_page_load_details 12:59:20 INFO - PROCESS | 1493 | |i|pagename|runs| 12:59:20 INFO - PROCESS | 1493 | |0;ai-astar;109;110;105;110;111;112;98;110;111;109 12:59:20 INFO - PROCESS | 1493 | |1;audio-beat-detection;160;140;154;163;127;149;157;130;164;128 12:59:20 INFO - PROCESS | 1493 | |2;audio-dft;163;161;161;160;160;162;163;164;161;162 12:59:20 INFO - PROCESS | 1493 | |3;audio-fft;74;83;73;148;76;76;74;77;164;75 12:59:20 INFO - PROCESS | 1493 | |4;audio-oscillator;96;96;142;94;95;95;148;95;95;136 12:59:20 INFO - PROCESS | 1493 | |5;imaging-gaussian-blur;109;110;108;109;109;109;109;109;108;108 12:59:20 INFO - PROCESS | 1493 | |6;imaging-darkroom;146;146;146;146;145;145;145;146;145;145 12:59:20 INFO - PROCESS | 1493 | |7;imaging-desaturate;97;97;95;96;96;95;95;96;96;96 12:59:20 INFO - PROCESS | 1493 | |8;json-parse-financial;54;55;55;55;54;55;55;55;54;54 12:59:20 INFO - PROCESS | 1493 | |9;json-stringify-tinderbox;64;66;64;65;65;65;65;64;65;64 12:59:20 INFO - PROCESS | 1493 | |10;stanford-crypto-aes;77;78;79;85;79;86;78;78;79;79 12:59:20 INFO - PROCESS | 1493 | |11;stanford-crypto-ccm;113;126;113;113;113;112;110;113;116;109 12:59:20 INFO - PROCESS | 1493 | |12;stanford-crypto-pbkdf2;137;138;132;135;134;124;139;131;142;134 12:59:20 INFO - PROCESS | 1493 | |13;stanford-crypto-sha256-iterative;65;66;62;62;66;64;65;65;64;64 12:59:20 INFO - PROCESS | 1493 | __end_tp_report 12:59:20 INFO - PROCESS | 1493 | __start_cc_report 12:59:20 INFO - PROCESS | 1493 | _x_x_mozilla_cycle_collect,955 12:59:20 INFO - PROCESS | 1493 | __end_cc_report 12:59:20 INFO - PROCESS | 1493 | __startTimestamp1457729960403__endTimestamp 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | ------- Summary: start ------- 12:59:20 INFO - PROCESS | 1493 | Number of tests: 14 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.14 (3.7%) stddev-sans-first:4.39 12:59:20 INFO - PROCESS | 1493 | Values: 109.0 110.0 105.0 110.0 111.0 112.0 98.0 110.0 111.0 109.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.50 stddev:14.78 (9.5%) stddev-sans-first:14.93 12:59:20 INFO - PROCESS | 1493 | Values: 160.0 140.0 154.0 163.0 127.0 149.0 157.0 130.0 164.0 128.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 12:59:20 INFO - PROCESS | 1493 | Values: 163.0 161.0 161.0 160.0 160.0 162.0 163.0 164.0 161.0 162.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:34.05 (45.1%) stddev-sans-first:35.49 12:59:20 INFO - PROCESS | 1493 | Values: 74.0 83.0 73.0 148.0 76.0 76.0 74.0 77.0 164.0 75.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.00 stddev:22.82 (24.0%) stddev-sans-first:23.70 12:59:20 INFO - PROCESS | 1493 | Values: 96.0 96.0 142.0 94.0 95.0 95.0 148.0 95.0 95.0 136.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 12:59:20 INFO - PROCESS | 1493 | Values: 109.0 110.0 108.0 109.0 109.0 109.0 109.0 109.0 108.0 108.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:59:20 INFO - PROCESS | 1493 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 12:59:20 INFO - PROCESS | 1493 | Values: 97.0 97.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 12:59:20 INFO - PROCESS | 1493 | Values: 54.0 55.0 55.0 55.0 54.0 55.0 55.0 55.0 54.0 54.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 12:59:20 INFO - PROCESS | 1493 | Values: 64.0 66.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:3.08 (3.9%) stddev-sans-first:3.10 12:59:20 INFO - PROCESS | 1493 | Values: 77.0 78.0 79.0 85.0 79.0 86.0 78.0 78.0 79.0 79.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:113.00 stddev:4.69 (4.1%) stddev-sans-first:4.96 12:59:20 INFO - PROCESS | 1493 | Values: 113.0 126.0 113.0 113.0 113.0 112.0 110.0 113.0 116.0 109.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.60 Median:136.00 stddev:4.99 (3.7%) stddev-sans-first:5.22 12:59:20 INFO - PROCESS | 1493 | Values: 137.0 138.0 132.0 135.0 134.0 124.0 139.0 131.0 142.0 134.0 12:59:20 INFO - PROCESS | 1493 | 12:59:20 INFO - PROCESS | 1493 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.48 12:59:20 INFO - PROCESS | 1493 | Values: 65.0 66.0 62.0 62.0 66.0 64.0 65.0 65.0 64.0 64.0 12:59:20 INFO - PROCESS | 1493 | -------- Summary: end -------- 12:59:20 INFO - PROCESS | 1493 | 12:59:21 INFO - TEST-INFO | 1493: exit 0 12:59:21 INFO - TEST-OK | kraken | took 57334ms 12:59:21 INFO - TEST-START | v8_7 12:59:21 INFO - operating with platform_type : linux_ 12:59:21 INFO - Initialising browser for v8_7 test... 12:59:21 INFO - TEST-INFO | started process 1749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDqUjT/profile http://localhost:50547/getInfo.html) 12:59:24 INFO - PROCESS | 1749 | __metrics Screen width/height:1600/1200 12:59:24 INFO - PROCESS | 1749 | colorDepth:24 12:59:24 INFO - PROCESS | 1749 | Browser inner width/height: 1024/697 12:59:24 INFO - PROCESS | 1749 | __metrics 12:59:24 INFO - PROCESS | 1749 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:25 INFO - TEST-INFO | 1749: exit 0 12:59:25 INFO - Browser initialized. 12:59:25 INFO - Running cycle 1/1 for v8_7 test... 12:59:25 INFO - TEST-INFO | started process 1838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDqUjT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:37 INFO - PROCESS | 1838 | RSS: Main: 135655424 12:59:37 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | Cycle 1(1): loaded http://localhost:50547/tests/v8_7/run.html (next: http://localhost:50547/tests/v8_7/run.html) 12:59:59 INFO - PROCESS | 1838 | RSS: Main: 422428672 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | __start_tp_report 12:59:59 INFO - PROCESS | 1838 | _x_x_mozilla_page_load 12:59:59 INFO - PROCESS | 1838 | _x_x_mozilla_page_load_details 12:59:59 INFO - PROCESS | 1838 | |i|pagename|runs| 12:59:59 INFO - PROCESS | 1838 | |0;Richards;166.47244880972198 12:59:59 INFO - PROCESS | 1838 | |1;DeltaBlue;169.4628029147602 12:59:59 INFO - PROCESS | 1838 | |2;Encrypt;278.55153203342616 12:59:59 INFO - PROCESS | 1838 | |3;Decrypt;5186.5284974093265 12:59:59 INFO - PROCESS | 1838 | |4;RayTrace;947.8672985781991 12:59:59 INFO - PROCESS | 1838 | |5;Earley;563.6978579481398 12:59:59 INFO - PROCESS | 1838 | |6;Boyer;10562.5 12:59:59 INFO - PROCESS | 1838 | |7;RegExp;41160 12:59:59 INFO - PROCESS | 1838 | |8;Splay;509.94390617032127 12:59:59 INFO - PROCESS | 1838 | |9;NavierStokes;4826.923076923077 12:59:59 INFO - PROCESS | 1838 | __end_tp_report 12:59:59 INFO - PROCESS | 1838 | __startTimestamp1457729999919__endTimestamp 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | ------- Summary: start ------- 12:59:59 INFO - PROCESS | 1838 | Number of tests: 10 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 166.5 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#1] DeltaBlue Cycles:1 Average:169.46 Median:169.46 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 169.5 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 278.6 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 5186.5 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#4] RayTrace Cycles:1 Average:947.87 Median:947.87 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 947.9 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#5] Earley Cycles:1 Average:563.70 Median:563.70 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 563.7 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#6] Boyer Cycles:1 Average:10562.50 Median:10562.50 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 10562.5 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#7] RegExp Cycles:1 Average:41160.00 Median:41160.00 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 41160.0 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#8] Splay Cycles:1 Average:509.94 Median:509.94 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 509.9 12:59:59 INFO - PROCESS | 1838 | 12:59:59 INFO - PROCESS | 1838 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 12:59:59 INFO - PROCESS | 1838 | Values: 4826.9 12:59:59 INFO - PROCESS | 1838 | -------- Summary: end -------- 12:59:59 INFO - PROCESS | 1838 | 13:00:00 INFO - TEST-INFO | 1838: exit 0 13:00:00 INFO - TEST-OK | v8_7 | took 39433ms 13:00:00 INFO - SUITE-END | took 1206s 13:00:00 INFO - Completed test suite (00:20:06) 13:00:00 INFO - Working with test: dromaeo_css 13:00:00 INFO - Generating results file: dromaeo_css 13:00:00 INFO - Working with test: kraken 13:00:00 INFO - Generating results file: kraken 13:00:00 INFO - javascript benchmark 13:00:00 INFO - Working with test: v8_7 13:00:00 INFO - Generating results file: v8_7 13:00:00 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 13:00:01 INFO - process_Request line: dromaeo_css 7144.46 graph.html#tests=[[72,181,35]] 13:00:01 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:01 INFO - process_Request line: kraken 1480.60 graph.html#tests=[[232,181,35]] 13:00:01 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:00:01 INFO - process_Request line: v8_7 22045.89 graph.html#tests=[[230,181,35]] 13:00:01 INFO - RETURN: dromaeo_css: 7144.46 13:00:01 INFO - RETURN: kraken: 1480.60 13:00:01 INFO - RETURN: v8_7: 22045.89 13:00:01 INFO - javascript benchmark 13:00:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3249.496328069149, 3283.310504793993, 3301.3232287381074, 3309.8014119152854, 3310.8013519188867, 5289.180177072551, 5301.2313214583955, 5303.575713942885, 5307.230451584518, 5339.038972984861, 5325.653832500894, 5326.627136100475, 5332.306800115989, 5363.517283444489, 5363.865903352418, 4799.616030717551, 4887.853364399056, 4892.975535122319, 4924.162892308298, 4926.261060840885, 4882.316475693406, 4936.950630493703, 4941.950580494203, 4944.802207911697, 4949.851504454854, 4905.82829600964, 4917.926231106536, 4934.40787105546, 4935.358403407552, 4937.80248790048, 4971.154903666367, 5014.222795466709, 5050.141475949061, 5054.873628159326, 5055.140626093536, 4973.055119527278, 5000.924986125211, 5013.298138260647, 5015.84952451427, 5047.217681259411, 5144.691318520863, 5155.0, 5227.2159176123505, 5228.215767634847, 5314.548263397616, 5806.65160090396, 5842.707864606753, 5842.853928651775, 5852.385499522531, 5866.442687944638, 5881.441263080001, 5883.470487656089, 5900.881982360372, 5906.970465147647, 5907.438793314628, 5216.400113986902, 5308.23030660552, 5429.185622156708, 5479.698616576126, 5595.356533998561, 5833.88332233353, 5839.211706419664, 5840.795572155039, 5847.912281315784, 5850.678212698257, 5613.354464236583, 5627.212190293362, 5629.352624448159, 5636.126400407943, 5636.436356364413, 5610.775568977277, 5703.971480142655, 5751.424857514216, 5829.358770535237, 5856.795012174553, 5779.450952159538, 5788.739506722208, 5789.507891829242, 5794.420557944172, 5828.59199856006, 5619.381867994517, 5761.193432919395, 5799.652020878676, 5802.390748971297, 5812.94187058124, 4355.1507456045765, 4382.342648602735, 4390.648748100144, 4399.428074350314, 4422.469303683579, 3947.0921688011344, 3954.940675889864, 3964.861229856941, 3984.86052988144, 3988.700847436454, 5344.786208551692, 5415.241866138744, 5416.7020813855615, 5428.782848686008, 5453.836384908459, 5822.301323841166, 5865.765369385177, 5882.617629854046, 5913.852153696192, 5945.227120474311, 5460.535854452337, 5517.834464966058, 5531.3362396512675, 5539.861503462445, 5550.250716153349, 4854.660173787872, 4943.060818444484, 4973.0, 5018.2974383586325, 5056.696598204119, 5994.6403215807195, 5998.9100163496705, 6000.879982400327, 6007.249093863267, 6011.5190784737115, 5817.981853175593, 5828.679422631796, 5834.329052158886, 5840.474357307693, 5848.152017957457, 5727.312722473163, 5836.912446313224, 5924.407559244213, 5968.940310596839, 6034.155218269533, 5758.452946970031, 5759.164921086335, 5760.798372056958, 5762.1068734346245, 5769.0, 5805.361410244954, 5825.912611310749, 5859.44335288147, 5862.296524417097, 5867.383924687846, 5546.306711661043, 5582.190582365453, 5621.4659607337235, 5684.289463817023, 5720.02759530889, 5718.714064296852, 5730.541556675373, 5734.111212762028, 5735.71321433935, 5737.368889422077, 5380.892382152257, 5640.943590564206, 5647.1529270609735, 5649.350324712711, 5658.632188907708, 5589.357223919302, 5700.344460386943, 5744.942550574441, 5763.9135412968, 5800.8259752207505, 5616.522595579421, 5646.548276137817, 5662.886742265214, 5664.745086471201, 5668.461496157858], "unit": "score", "name": "dojo.html", "value": 5345.685928011687}, {"lowerIsBetter": false, "replicates": [542.9049916264653, 560.963537370071, 561.068626080706, 566.19882865745, 581.8399940016492, 29996.700032999663, 30476.39047219057, 38066.80966595167, 38345.42481862774, 38437.615623843754, 42379.57620423795, 42819.14361712764, 42864.57135428645, 42913.356299655454, 42932.14135717291, 8760.8685869712, 8958.417702849294, 8971.05803890592, 8972.775680607972, 8973.596188171548, 8576.05663377028, 8715.607797649089, 8720.258778003878, 8721.95639021804, 8724.52015139167, 8945.239654629364, 9026.23277021454, 9026.368154229207, 9029.097090290985, 9031.277497800193, 8898.065703101178, 8901.465912045232, 8964.103589641049, 8980.416272942239, 8982.550872456384, 8875.556222188865, 8907.064758200426, 8936.195742383152, 9018.053104424072, 9023.593938272794, 42200.0, 42546.0, 42674.57325426737, 42682.78658606718, 42691.14617707628, 3384.8984530464127, 3386.1196089016785, 3479.7216222702377, 3675.467057276707, 3758.3047136279874, 30795.0, 32292.838535807405, 32417.35165296681, 32440.0, 33145.33709325824, 4087.1825634873144, 4137.420761093449, 4185.22573323936, 4227.1524688116115, 4272.530021697611, 292086.0, 293782.0, 294369.0, 294619.0, 300672.0, 61362.69318653468, 62476.0, 62608.37391626026, 62779.0, 62840.68579657164, 57008.714956425785, 57078.7146064267, 57087.714561427754, 57241.0, 57278.7136064317, 14671.0, 14793.852061479463, 14804.18576978255, 14810.111393316436, 14814.481493147689, 9836.655717050013, 9842.557084931195, 9872.802543949081, 9936.850947235796, 10059.144972677404, 20135.697964530544, 20483.69274460884, 20495.18019279242, 20509.17963281482, 20519.4870128248, 7551.186650741451, 7888.092869320101, 7915.841683166304, 7916.960415198002, 7940.722074727357, 1046.1787496814964, 1066.7013236293851, 1079.3847506921136, 1171.5840876488894, 1219.5975328141692, 29706.257343566584, 30180.84909575438, 30860.22849428782, 31094.53358199629, 31161.0, 1100.9174311926638, 1129.615930583589, 1141.7944769941323, 1156.3582211872492, 1298.6623477895625, 13164.802527962089, 13728.382222799997, 13852.991316259287, 14004.089734167246, 14957.70084598302, 356027.0, 366812.0, 367126.0, 367466.0, 367886.0, 53738.731306343216, 54036.459635403146, 54056.459435405144, 54094.64763380947, 54147.729261353445, 1296.6434230586476, 1373.3133433283358, 1387.9722405551831, 1458.9489367872075, 1474.3954978458994, 25582.744172558036, 25701.87149064243, 27579.72420275852, 27749.86125069362, 28289.71710282871, 43573.0, 43750.78124609357, 43775.56224437715, 43822.34266486069, 43963.78018109889, 231234.0, 232716.0, 233546.0, 234340.0, 234884.0, 32297.0, 32643.836780815946, 32766.34467310688, 32968.0, 33130.337393252485, 43266.783666081465, 44299.55700443083, 44459.110157839634, 44529.0, 44940.775296124615, 36756.44865327076, 37125.814370927976, 37712.24575508529, 37726.245475089796, 38674.6132538671, 36583.63416365909, 37217.25565488621, 37779.81110094432, 38122.237555249296, 38394.80802595969, 37896.43155352617, 38021.42967855429, 38162.80918595389, 38286.42570361391, 38307.0, 31221.375572488876, 31662.0, 32003.519947201275, 32146.678533215305, 32249.677503225605, 33846.492302615974, 33969.66030339665, 34139.65860341365, 34195.658043419244, 34236.31527369488], "unit": "score", "name": "ext.html", "value": 18873.366526809583}, {"lowerIsBetter": false, "replicates": [373.05616789522503, 380.68022860796935, 382.2736800079848, 382.88322061771146, 383.1188266985932, 14251.50119745809, 15461.5361539154, 15830.76253856193, 17821.10894455277, 17963.640727185466, 16640.916795416008, 16731.83268167318, 16983.91508042458, 17901.373451929187, 17904.104794760242, 4151.937720934188, 5472.890542189154, 5676.971615141919, 5679.318481782171, 5682.119271512922, 4285.978570107145, 5841.620294680833, 6035.094735789623, 6036.913355595991, 6038.51691864652, 5829.271341082364, 5955.1960485334575, 6114.633122012693, 6117.113018612298, 6120.387961203888, 5885.352611212763, 6021.217241758565, 6041.667708276043, 6070.878582428349, 6186.288576813679, 5432.782688692487, 5473.616846820724, 5474.233607294982, 5474.616776825624, 5475.780968761244, 20156.193752249892, 20401.5919681607, 20409.795902041085, 20582.897085514476, 20796.58406831855, 2357.422431504275, 2371.679823223877, 2375.8930848111704, 2443.1082654830857, 2468.790152837011, 9386.108319709616, 9636.566354514063, 13021.934890325583, 13200.73598528024, 13326.0, 1742.1028170492207, 1759.876808623397, 1807.8734488585803, 1869.5045812859603, 1871.167330537911, 56351.71824140853, 56386.15420768733, 56644.15033774497, 56758.43241567573, 58312.70843645797, 10743.731406714738, 10836.133109351233, 10876.510557024953, 10894.564217431373, 10960.12319014477, 14281.071730337495, 14304.356303966346, 14420.495282665057, 14421.0, 14426.783598246035, 7620.085589729268, 7650.502717323357, 7713.884291735629, 7716.845663086707, 7738.845223095506, 6807.115075040213, 6872.0, 6876.656167191621, 6884.173899132136, 7041.0, 4284.335927931175, 4494.977525112354, 4497.325401189848, 4695.483496815347, 4769.165396055676, 1726.180064469367, 1758.384565402099, 1822.8723989320886, 1874.9718754218698, 1880.3230836898706, 894.8165626046645, 917.9541022948825, 962.0475729028211, 1008.7881544875659, 1034.9340179615008, 16659.750103748454, 16936.915315423343, 17590.2084406202, 17833.375831845824, 18307.35924242645, 994.4480813148627, 1010.2625083688948, 1029.9742506437399, 1031.783325501653, 1038.117600039975, 9902.752431189134, 10064.647737329306, 10709.410982396043, 10712.143028557697, 10732.73168170802, 543857.0, 568629.0, 570177.0, 582948.0, 619138.0, 76180.61909690416, 76634.6168269155, 76735.61632191803, 78741.0, 79200.0, 1250.493550112206, 1252.8997680185564, 1255.0461649146532, 1257.6038547857395, 1277.2464246094848, 15776.447824326093, 15837.524874253791, 15893.761593575875, 16027.0, 16155.27301271422, 35468.290634186655, 35825.64174358223, 36236.81881590681, 36358.0, 36620.26759464849, 44619.33071004003, 45227.54772452233, 46131.76934115308, 47196.7640161797, 47311.0, 7635.618219088912, 7870.094939082079, 7936.484128531627, 7962.601869906597, 8052.476589021695, 4630.795993041901, 9923.950380248052, 10146.0, 11668.358240296866, 12006.63980080599, 9515.191208747057, 9596.18432433251, 9759.268054895769, 9789.0, 10034.19726421899, 10039.196864250696, 10187.439690817077, 10498.842517362093, 10543.894561054598, 10707.840983093218, 9012.098790120936, 9373.718788436357, 9442.905570944478, 9487.66793162236, 9577.185939195246, 7713.575753333621, 7756.3019328260725, 7764.92235077642, 7785.416093793101, 7808.0, 7125.572465652078, 9435.481048542397, 9500.762480937756, 9734.41593504392, 9967.800643987224], "unit": "score", "name": "jquery.html", "value": 8552.064011045371}, {"lowerIsBetter": false, "replicates": [1539.3534715419523, 1550.9224538773058, 1736.5571779196302, 1843.6865732825418, 1851.9259229630807, 8015.519068855872, 8149.4702844315225, 8184.672613095477, 8204.753857384288, 8234.17658234177, 7078.964605176967, 7230.349268565828, 7690.500117492359, 7747.767566973, 7896.052473703164, 2410.6745589345433, 2420.6369044643357, 2445.327534927891, 2450.546648869956, 2451.3626457121186, 2046.130394582304, 2400.6879105716234, 2431.3192306154215, 2439.560879041772, 2446.926592202237, 2126.9361919142375, 2380.059876348841, 2433.3916520869784, 2435.768601982809, 2435.9878200608973, 2391.4858305464236, 2408.2895545814026, 2437.2688193541867, 2447.363685441789, 2450.4363996280867, 2389.7371289158177, 2430.769076937688, 2442.0842184180933, 2446.8409553378974, 2446.9143579974616, 7845.490043147177, 7846.372290216769, 7862.488938218998, 7893.881591776128, 8094.3524518039, 5024.748762561857, 5075.111855425286, 5088.949110508885, 5137.922931156036, 5148.9485105149215, 3130.6869313068737, 3138.717515423623, 3166.667499912522, 3213.8714451421915, 3240.3843269778904, 993.4883534979491, 1000.929934904557, 1013.4780587997187, 1023.0, 1040.7554224757175, 11327.943360283229, 11615.070794336432, 11637.301761894229, 11644.126690498246, 11644.650660480114, 4531.161735079021, 4584.587387135174, 4661.440627124699, 4686.226772582554, 4691.7654117294, 9813.754656133511, 9831.213502919749, 9836.60653573849, 9849.60601575929, 9856.901430985741, 5206.401263854629, 5212.765425555859, 5213.661112027706, 5217.3999990000875, 5223.738813059332, 4621.376114224604, 4684.578387945101, 4685.718856868531, 4690.835820746258, 4692.131955588227, 3828.9617103829164, 3839.251345987506, 3874.2638898609175, 3875.399313106473, 3913.7064720146104, 1208.7763763703742, 1223.5350566784564, 1229.6188181663713, 1237.1216436330305, 1238.504598160743, 1157.8147496400536, 1158.7392836611696, 1179.4928180882303, 1182.018924292835, 1259.3703148425786, 7714.074311082706, 7794.688212471551, 7795.610219489116, 7836.882446763303, 7944.6027698614835, 1160.640201537526, 1185.466540056978, 1190.3691043746828, 1190.9940450297865, 1191.0828661930266, 5884.9705751470965, 5910.645361278337, 5939.970300148471, 5945.10823376497, 5968.910466343008, 9131.406458580172, 9825.312228144105, 9829.55766990487, 9855.55649995752, 9934.950325248328, 9656.468894210746, 9657.420554766595, 9757.073078057572, 10099.7475063124, 10152.340097893613, 7406.777796666109, 7762.262585054524, 7800.024996875391, 7864.449488535747, 7872.44892857506, 7629.580373079534, 7666.501677390952, 7680.692772289046, 7694.769156925301, 7716.691332346643, 8625.223729864343, 8962.910370896469, 9007.05425930294, 9018.909810901807, 9050.864237036318, 9036.23192028685, 9057.728268151966, 9148.862767058632, 9244.676436324697, 9318.0, 7059.647017649199, 7167.49482608658, 7171.748988785367, 7198.820029499305, 7208.423326134001, 7908.209179082046, 7914.24814642608, 7931.36549076061, 8007.079185893696, 8065.9596702016115, 6832.077669514552, 7537.397008239437, 7607.923920760722, 7702.922970770444, 7740.7677769667, 6880.2431732508385, 7288.12542494904, 7291.708331666674, 7392.371648409945, 7430.851382972202, 7502.549847008979, 7608.467407281437, 7615.619219039137, 7617.047869016373, 7623.733169339268, 6826.249112597511, 6973.407260382722, 6993.790186294419, 6994.475414343843, 7002.7899163025195, 6789.083473731181, 6876.381125698711, 6890.44876409896, 6890.689918953759, 6890.758823441356], "unit": "score", "name": "mootools.html", "value": 4748.405664389865}, {"lowerIsBetter": false, "replicates": [354.4576797499826, 361.6275236506398, 363.1913072896973, 368.38847513128206, 371.3649659082969, 6049.939500604998, 6058.424449677279, 6076.908846367308, 6079.179310793042, 6089.634621922688, 5704.11586204139, 5838.766449342032, 5870.61840980336, 6003.909941350883, 6015.127806468059, 4706.458757242909, 4712.764361781914, 4724.551167639086, 4725.432948046239, 4745.715257084568, 4495.685302028859, 4718.764061796914, 4733.195356789354, 4734.621230301585, 4745.92881106782, 4552.9089418211615, 4557.225271703802, 4628.30575413689, 4672.6729128960815, 4693.436787585494, 4661.067786442725, 4664.55686709762, 4669.066186762627, 4689.320048592969, 4691.3432119503295, 4165.97917010416, 4172.749635021908, 4174.102567947875, 4174.3947127666315, 4178.6657067434535, 5596.860078498029, 5759.164921086419, 5763.625364351304, 5774.913376299359, 5776.249087618583, 5303.071962406563, 5303.761330740126, 5307.628466007381, 5310.57515398771, 5315.255864179018, 6405.29541750407, 6433.8391540211405, 6434.356564343575, 6441.645709485976, 6510.707018184193, 4460.041091165415, 4463.933041004388, 4465.263231566788, 4466.12910482456, 4469.1732029574305, 6555.901661475082, 6600.273969863311, 6672.799816005528, 6675.46596272297, 6682.231543372526, 4586.541345865454, 4601.700889442175, 4602.930956035662, 4603.286490593963, 4615.0, 4670.112678591125, 4675.555822196886, 4676.181668208118, 4678.087772884323, 4682.695624784378, 5358.410574836765, 5366.570674346121, 5377.919331210035, 5382.381026181961, 5383.946160538423, 6288.308286088527, 6439.22729272481, 6443.5167362448, 6455.7740479083, 6464.321246269168, 1623.9431619893483, 1631.4208455998187, 1631.616570106024, 1632.6000129968234, 1634.2645809385824, 1092.9617463388743, 1103.1836441033577, 1105.5798796457295, 1124.5052177042076, 1124.7571433565793, 6202.131701561785, 6207.34822843604, 6212.875742485125, 6213.285472170668, 6220.222472190976, 6397.840053998687, 6634.834129146713, 6638.070670106189, 6646.567973081831, 6650.068990341356, 6121.938780612226, 6129.816105516842, 6282.057691346335, 6282.2147231596055, 6283.371662833772, 3567.126054116706, 3598.3522965865873, 3601.9099522511624, 3601.94597081044, 3607.3867442534834, 6658.167729033871, 6707.3628005339415, 6797.898031529531, 6832.419244364185, 6834.077399550997, 6853.485988550879, 6866.0, 6881.793546193622, 6883.208431030395, 6885.793426197222, 6830.112085428962, 6843.0, 6849.075374824434, 6854.451643868479, 6857.622830744257, 6538.574992625464, 6684.899726504009, 6690.163729533809, 6695.096162018065, 6704.262531121671, 6562.245341785565, 6573.211214654272, 6576.145101136822, 6580.045893345534, 6580.440662543738, 6815.693293801692, 6822.965885170543, 6825.839607266677, 6827.795166145023, 6828.385445309946, 4587.243104887656, 4655.255159174516, 4664.323673067318, 4665.0, 4668.78990445424, 6665.833354166185, 6688.130543029375, 6692.564983276072, 6693.598384096969, 6694.230163531061, 6441.838954026187, 6493.0, 6521.152250207632, 6556.409923106943, 6560.704768285344, 6387.137736405712, 6464.22429308486, 6481.740730370732, 6486.708098135501, 6496.545241833026, 6277.623342599459, 6329.588576742497, 6329.841753956004, 6332.746690132343, 6393.104965304954, 6527.3472652734345, 6583.0, 6583.144191255106, 6584.473242140713, 6607.669616519251, 6136.325004249618, 6359.87280254383, 6368.872622547616, 6370.840728981812, 6371.5221358397375], "unit": "score", "name": "prototype.html", "value": 4880.780043907153}, {"lowerIsBetter": false, "replicates": [914.6935776514867, 922.2575826459706, 925.421611492817, 926.7451450851015, 938.2400255792807, 13724.451021959123, 14128.011039227258, 14146.434142634294, 14160.57518274451, 14167.504137355194, 13418.530351437701, 13477.326133693325, 13498.0, 13509.18944863309, 13514.72970540591, 709.2588245283665, 719.5466855880787, 876.0101085773099, 879.8152387998496, 895.3285036222849, 824.9422540422173, 882.1046637662778, 899.622158693347, 900.4147304252223, 900.8693739407782, 925.7315378540216, 926.2451102351596, 928.067292371166, 928.4336554701626, 928.749237705819, 752.1763668782702, 763.6487215880702, 912.1608120529129, 922.3267015078997, 932.1098351074708, 675.9391654751047, 677.7898851356047, 678.6335378895391, 682.5290549520814, 683.2791405067652, 13710.794338084937, 13740.725185496334, 13755.0, 13776.897848172122, 13778.0, 12744.235345879184, 13333.134242184396, 13455.529056483074, 13455.798163027563, 13490.0, 10759.569617215302, 10935.234533582652, 11023.44882755859, 11059.22585419021, 11194.04850587701, 3843.500344955166, 3845.8653947111998, 3849.095462566295, 3872.0, 3874.670652994499, 48938.26592601114, 49382.25926611104, 49833.0, 49910.0, 50198.24702629464, 10419.166466682647, 10466.372017678963, 10538.367697938149, 10551.736206594896, 10640.627578034731, 19635.803641963397, 19757.506062348555, 19760.70358944617, 19801.504962376057, 19838.70241946372, 7720.112187098443, 7771.222877712184, 7863.0957439894, 7913.762587122281, 8071.031476222891, 4332.740035597874, 4489.483709373399, 4559.38448309474, 4602.4477062752685, 4603.838865639686, 3304.4052070627517, 3333.6499667535045, 3335.832458639457, 3337.1156643489494, 3350.7654464187763, 565.1776664952484, 580.7386675995734, 582.4437662032749, 586.7359688140353, 596.1058412381428, 687.4637782529635, 706.2901783707341, 711.7402148215864, 712.5617745086838, 717.5551158281794, 8559.871601925975, 9169.95415022934, 9265.675701350421, 9308.115729005734, 9844.60621575129, 542.481929757081, 542.956563474929, 548.1749966300692, 586.489753914089, 685.1093578348127, 4188.518320393194, 4253.447051883235, 4255.97872010638, 4357.237483440449, 4359.498657654347, 58550.0, 58963.705181473815, 59249.40750592439, 59805.700971494865, 59854.40145598575, 48582.51417485851, 55015.724921375135, 55865.0, 56000.0, 56020.71989640026, 47282.29076563854, 47647.0, 48475.75762121167, 48643.0, 49491.25763113484, 9437.905620943702, 9486.857697134687, 9660.130588247092, 9778.462184579916, 9814.312998090065, 33355.332893342485, 33797.83101084577, 34302.14244643904, 34461.65538344685, 34586.30827383488, 42621.786891066586, 42937.35593966155, 46506.767466162455, 46620.53379466162, 47218.0, 12108.939455302667, 12154.453049612965, 12249.326287054297, 12451.25292482454, 12530.561430349893, 12514.687132821753, 12528.0, 12748.74502509926, 12774.36128193568, 13418.261995590336, 12256.264624122581, 12280.508779648713, 12763.170393924365, 13038.934805325913, 13039.674008149872, 12479.93760031194, 12698.873011269769, 12735.55425560101, 12770.42533086032, 12853.100282980102, 10403.167746580104, 11531.481083351102, 11866.228695134789, 12200.0, 12782.105252632227, 9844.310898237054, 9848.359856609297, 9977.60089596408, 10149.847752283575, 10189.54147063369, 9682.080202380763, 9717.951410242904, 9793.265505087005, 10014.94992525062, 10062.295639305179], "unit": "score", "name": "yui.html", "value": 6649.953043257362}], "name": "dromaeo_css", "value": 7144.457206769134}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 111.0, 112.0, 98.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [160.0, 140.0, 154.0, 163.0, 127.0, 149.0, 157.0, 130.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 160.0, 160.0, 162.0, 163.0, 164.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [74.0, 83.0, 73.0, 148.0, 76.0, 76.0, 74.0, 77.0, 164.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 94.0, 95.0, 95.0, 148.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 85.0, 79.0, 86.0, 78.0, 78.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [113.0, 126.0, 113.0, 113.0, 113.0, 112.0, 110.0, 113.0, 116.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.8}, {"lowerIsBetter": true, "replicates": [137.0, 138.0, 132.0, 135.0, 134.0, 124.0, 139.0, 131.0, 142.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 62.0, 62.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1480.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [169.4628029147602], "unit": "score", "name": "DeltaBlue", "value": 390.1623180000001}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [947.8672985781991], "unit": "score", "name": "RayTrace", "value": 780.6883950000001}, {"lowerIsBetter": false, "replicates": [563.6978579481398], "unit": "score", "name": "Earley", "value": 1182.3053619999998}, {"lowerIsBetter": false, "replicates": [10562.5], "unit": "score", "name": "Boyer", "value": 63.09708875739642}, {"lowerIsBetter": false, "replicates": [41160.0], "unit": "score", "name": "RegExp", "value": 22.132774538386794}, {"lowerIsBetter": false, "replicates": [509.94390617032127], "unit": "score", "name": "Splay", "value": 159.80385100000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22045.886957092946}]} 13:00:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,181,35]]", "result": "22045.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1480.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7144.46"}}} 13:00:01 INFO - Return code: 0 13:00:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:00:01 INFO - # TBPL SUCCESS # 13:00:01 INFO - Running post-action listener: _resource_record_post_action 13:00:01 INFO - Running post-run listener: _resource_record_post_run 13:00:02 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 472358912; Read time: 0; Write time: 453508 13:00:02 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 244080640; Read time: 0; Write time: 322348 13:00:02 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 228278272; Read time: 0; Write time: 131160 13:00:02 INFO - Running post-run listener: _upload_blobber_files 13:00:02 INFO - Blob upload gear active. 13:00:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:02 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 13:00:02 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'] 13:00:02 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 13:00:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:03 INFO - (blobuploader) - INFO - Done attempting. 13:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:04 INFO - (blobuploader) - INFO - Done attempting. 13:00:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:04 INFO - Return code: 0 13:00:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/6a9780f505f2ad960871cd8967ffcfec4e1dc7b06e4a22ece92c85539f69833b35c5cd65bf0735ffedacda11c3cc1846a05741a109da9a41387b8c8dba819245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1405e5c2b42264dcb4a97255f6e2cfbc4fc37470a517db8d8f1e309426228d27cd059c5ca04811a0a489d4fa8b9a9fad0c042393b02a91e5381e55f568181177"} 13:00:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:04 INFO - Contents: 13:00:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/6a9780f505f2ad960871cd8967ffcfec4e1dc7b06e4a22ece92c85539f69833b35c5cd65bf0735ffedacda11c3cc1846a05741a109da9a41387b8c8dba819245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1405e5c2b42264dcb4a97255f6e2cfbc4fc37470a517db8d8f1e309426228d27cd059c5ca04811a0a489d4fa8b9a9fad0c042393b02a91e5381e55f568181177"} 13:00:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:04 INFO - Copying logs to upload dir... 13:00:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.249359 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-11 13:00:04.544750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:04.548836) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 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/6a9780f505f2ad960871cd8967ffcfec4e1dc7b06e4a22ece92c85539f69833b35c5cd65bf0735ffedacda11c3cc1846a05741a109da9a41387b8c8dba819245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1405e5c2b42264dcb4a97255f6e2cfbc4fc37470a517db8d8f1e309426228d27cd059c5ca04811a0a489d4fa8b9a9fad0c042393b02a91e5381e55f568181177"} build_url:https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/Q7NeNGS0QHaAldsjYTcY7A/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/6a9780f505f2ad960871cd8967ffcfec4e1dc7b06e4a22ece92c85539f69833b35c5cd65bf0735ffedacda11c3cc1846a05741a109da9a41387b8c8dba819245", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/1405e5c2b42264dcb4a97255f6e2cfbc4fc37470a517db8d8f1e309426228d27cd059c5ca04811a0a489d4fa8b9a9fad0c042393b02a91e5381e55f568181177"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:04.579810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:04.580157) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1457728683.183447-849232126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 13:00:04.634092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:00:04.634751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 13:00:04.635053) ========= ========= Total master_lag: 0.28 =========