builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1495791708.78 results: success (0) revision: bedd24174ff464c4318db7224aa47ba84c25abec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.780612) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.781116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.781555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.803198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.803463) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 02:41:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-05-26 02:41:49 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.905657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.905950) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022496 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:48.965097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 02:41:48.965412) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bedd24174ff464c4318db7224aa47ba84c25abec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev bedd24174ff464c4318db7224aa47ba84c25abec --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=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 02:41:49,796 truncating revision to first 12 chars 2017-05-26 02:41:49,796 Setting DEBUG logging. 2017-05-26 02:41:49,796 attempt 1/10 2017-05-26 02:41:49,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bedd24174ff4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 02:41:51,219 unpacking tar archive at: mozilla-central-bedd24174ff4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.796498 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 02:41:50.788284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:50.788606) ========= script_repo_revision: bedd24174ff464c4318db7224aa47ba84c25abec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:50.788981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:50.789301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 02:41:50.798094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-26 02:41:50.798399) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:41:51 INFO - MultiFileLogger online at 20170526 02:41:51 in /builds/slave/test 02:41:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:41:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:51 INFO - {'append_to_log': False, 02:41:51 INFO - 'base_work_dir': '/builds/slave/test', 02:41:51 INFO - 'blob_upload_branch': 'Firefox', 02:41:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:51 INFO - 'branch': 'Firefox', 02:41:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:51 INFO - 'config_files': ('talos/linux_config.py',), 02:41:51 INFO - 'default_actions': ('clobber', 02:41:51 INFO - 'read-buildbot-config', 02:41:51 INFO - 'download-and-extract', 02:41:51 INFO - 'populate-webroot', 02:41:51 INFO - 'create-virtualenv', 02:41:51 INFO - 'install', 02:41:51 INFO - 'run-tests'), 02:41:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:51 INFO - 'download_minidump_stackwalk': True, 02:41:51 INFO - 'download_symbols': 'ondemand', 02:41:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:51 INFO - 'gecko_profile': False, 02:41:51 INFO - 'gecko_profile_interval': 0, 02:41:51 INFO - 'installer_path': 'installer.exe', 02:41:51 INFO - 'log_level': 'info', 02:41:51 INFO - 'log_name': 'talos', 02:41:51 INFO - 'log_to_console': True, 02:41:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:41:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:41:51 INFO - 'opt_config_files': (), 02:41:51 INFO - 'pip_index': False, 02:41:51 INFO - 'suite': 'dromaeojs-e10s', 02:41:51 INFO - 'system_bits': '32', 02:41:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:51 INFO - 'title': 'talos-linux64-ix-029', 02:41:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:51 INFO - 'use_talos_json': True, 02:41:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:51 INFO - 'work_dir': 'build'} 02:41:51 INFO - [mozharness: 2017-05-26 09:41:51.721388Z] Running clobber step. 02:41:51 INFO - Running pre-action listener: _resource_record_pre_action 02:41:51 INFO - Running main action method: clobber 02:41:51 INFO - rmtree: /builds/slave/test/build 02:41:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:52 INFO - Running post-action listener: _resource_record_post_action 02:41:52 INFO - [mozharness: 2017-05-26 09:41:52.751621Z] Finished clobber step (success) 02:41:52 INFO - [mozharness: 2017-05-26 09:41:52.751733Z] Running read-buildbot-config step. 02:41:52 INFO - Running pre-action listener: _resource_record_pre_action 02:41:52 INFO - Running main action method: read_buildbot_config 02:41:52 INFO - Using buildbot properties: 02:41:52 INFO - { 02:41:52 INFO - "project": "", 02:41:52 INFO - "product": "firefox", 02:41:52 INFO - "who": "cbook@mozilla.com", 02:41:52 INFO - "installer_path": "public/build/target.tar.bz2", 02:41:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:41:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:41:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:41:52 INFO - "stage_platform": "linux64-stylo", 02:41:52 INFO - "basedir": "/builds/slave/test", 02:41:52 INFO - "buildnumber": 120, 02:41:52 INFO - "platform": "ubuntu64_hw_stylo", 02:41:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:41:52 INFO - "slavebuilddir": "test", 02:41:52 INFO - "taskId": "KmM6A-kDRK6rrsLKfW8DNA", 02:41:52 INFO - "branch": "mozilla-central", 02:41:52 INFO - "script_repo_revision": "production", 02:41:52 INFO - "revision": "bedd24174ff464c4318db7224aa47ba84c25abec", 02:41:52 INFO - "slavename": "talos-linux64-ix-029", 02:41:52 INFO - "repo_path": "mozilla-central" 02:41:52 INFO - } 02:41:52 INFO - Finding installer, test and symbols from parent task. 02:41:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KmM6A-kDRK6rrsLKfW8DNA'}, attempt #1 02:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KmM6A-kDRK6rrsLKfW8DNA'}, attempt #1 02:41:53 INFO - Task dependencies: J_CEey7SRvWRCPi0ZJeLZA 02:41:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA'}, attempt #1 02:41:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 02:41:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/test_packages.json 02:41:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.crashreporter-symbols.zip 02:41:54 INFO - Running post-action listener: _resource_record_post_action 02:41:54 INFO - [mozharness: 2017-05-26 09:41:54.111279Z] Finished read-buildbot-config step (success) 02:41:54 INFO - [mozharness: 2017-05-26 09:41:54.111498Z] Running download-and-extract step. 02:41:54 INFO - Running pre-action listener: _resource_record_pre_action 02:41:54 INFO - Running main action method: download_and_extract 02:41:54 INFO - mkdir: /builds/slave/test/build/tests 02:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:54 INFO - trying https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.test_packages.json 02:41:54 INFO - Downloading https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:41:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:41:54 INFO - Downloaded 986 bytes. 02:41:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:41:54 INFO - Using the following test package requirements: 02:41:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:41:54 INFO - u'common': [u'target.common.tests.zip'], 02:41:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:41:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:41:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:41:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:41:54 INFO - u'mozbase': [u'target.common.tests.zip'], 02:41:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:41:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:41:54 INFO - u'web-platform': [u'target.common.tests.zip', 02:41:54 INFO - u'target.web-platform.tests.zip'], 02:41:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:41:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:41:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip 02:41:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:41:54 INFO - Fetch https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip into memory 02:41:56 INFO - Content-Length response header: 63525244 02:41:56 INFO - Bytes received: 63525244 02:42:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip 02:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.common.tests.zip into memory 02:42:08 INFO - Content-Length response header: 63525244 02:42:08 INFO - Bytes received: 63525244 02:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.talos.tests.zip 02:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.talos.tests.zip into memory 02:42:21 INFO - Content-Length response header: 14411888 02:42:21 INFO - Bytes received: 14411888 02:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:21 INFO - trying https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 02:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:42:23 INFO - Downloaded 55842303 bytes. 02:42:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 02:42:23 INFO - mkdir: /builds/slave/test/properties 02:42:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:42:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:42:23 INFO - Contents: 02:42:23 INFO - build_url:https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 02:42:23 INFO - Running post-action listener: _resource_record_post_action 02:42:23 INFO - Running post-action listener: set_extra_try_arguments 02:42:23 INFO - [mozharness: 2017-05-26 09:42:23.424884Z] Finished download-and-extract step (success) 02:42:23 INFO - [mozharness: 2017-05-26 09:42:23.425112Z] Running populate-webroot step. 02:42:23 INFO - Running pre-action listener: _resource_record_pre_action 02:42:23 INFO - Running main action method: populate_webroot 02:42:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:42:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:42:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:42:23 INFO - '--tppagecycles', 02:42:23 INFO - '7'], 02:42:23 INFO - 'tests': ['tsvgm']}}, 02:42:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:42:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:42:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:42:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:42:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['damp', 'tps']}, 02:42:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'tests': ['damp', 'tps']}, 02:42:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['dromaeo_dom']}, 02:42:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:42:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:42:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:42:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:42:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['a11yr', 02:42:23 INFO - 'ts_paint', 02:42:23 INFO - 'tpaint', 02:42:23 INFO - 'sessionrestore', 02:42:23 INFO - 'sessionrestore_no_auto_restore', 02:42:23 INFO - 'tabpaint']}, 02:42:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:42:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:42:23 INFO - 'bloom_basic_ref']}, 02:42:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['tsvgx', 02:42:23 INFO - 'tsvgr_opacity', 02:42:23 INFO - 'tart', 02:42:23 INFO - 'tscrollx', 02:42:23 INFO - 'cart', 02:42:23 INFO - 'tsvg_static']}, 02:42:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:42:23 INFO - 'tsvgr_opacity', 02:42:23 INFO - 'tart', 02:42:23 INFO - 'tscrollx', 02:42:23 INFO - 'cart', 02:42:23 INFO - 'tsvg_static']}, 02:42:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'talos_options': ['--disable-e10s'], 02:42:23 INFO - 'tests': ['tp5o']}, 02:42:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:42:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'talos_options': ['--disable-e10s', 02:42:23 INFO - '--xperf_path', 02:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:23 INFO - 'tests': ['tp5n']}, 02:42:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:42:23 INFO - 'talos_options': ['--xperf_path', 02:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:23 INFO - 'tests': ['tp5n']}}, 02:42:23 INFO - 'talos.zip': {'path': '', 02:42:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:42:23 INFO - Running post-action listener: _resource_record_post_action 02:42:23 INFO - [mozharness: 2017-05-26 09:42:23.444321Z] Finished populate-webroot step (success) 02:42:23 INFO - [mozharness: 2017-05-26 09:42:23.444410Z] Running create-virtualenv step. 02:42:23 INFO - Running pre-action listener: _resource_record_pre_action 02:42:23 INFO - Running main action method: create_virtualenv 02:42:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:42:23 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 02:42:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:42:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:42:23 INFO - Using real prefix '/usr' 02:42:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:42:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:42:26 INFO - Installing pip.................done. 02:42:26 INFO - Return code: 0 02:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:42:26 INFO - Reading from file tmpfile_stdout 02:42:26 INFO - Output received: 02:42:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:42:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:42:26 INFO - Using env: {'DISPLAY': ':0', 02:42:26 INFO - 'HOME': '/home/cltbld', 02:42:26 INFO - 'LANG': 'en_US.UTF-8', 02:42:26 INFO - 'LANGUAGE': 'en_US:en', 02:42:26 INFO - 'LOGNAME': 'cltbld', 02:42:26 INFO - 'MAIL': '/var/mail/cltbld', 02:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:26 INFO - 'MOZ_NO_REMOTE': '1', 02:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:26 INFO - 'NO_EM_RESTART': '1', 02:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:26 INFO - 'PWD': '/builds/slave/test', 02:42:26 INFO - 'SHELL': '/bin/bash', 02:42:26 INFO - 'SHLVL': '1', 02:42:26 INFO - 'TERM': 'linux', 02:42:26 INFO - 'TMOUT': '86400', 02:42:26 INFO - 'USER': 'cltbld', 02:42:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:26 INFO - '_': '/tools/buildbot/bin/python'} 02:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:26 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 02:42:26 INFO - Cleaning up... 02:42:26 INFO - Return code: 0 02:42:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:42:26 INFO - Using env: {'DISPLAY': ':0', 02:42:26 INFO - 'HOME': '/home/cltbld', 02:42:26 INFO - 'LANG': 'en_US.UTF-8', 02:42:26 INFO - 'LANGUAGE': 'en_US:en', 02:42:26 INFO - 'LOGNAME': 'cltbld', 02:42:26 INFO - 'MAIL': '/var/mail/cltbld', 02:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:26 INFO - 'MOZ_NO_REMOTE': '1', 02:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:26 INFO - 'NO_EM_RESTART': '1', 02:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:26 INFO - 'PWD': '/builds/slave/test', 02:42:26 INFO - 'SHELL': '/bin/bash', 02:42:26 INFO - 'SHLVL': '1', 02:42:26 INFO - 'TERM': 'linux', 02:42:26 INFO - 'TMOUT': '86400', 02:42:26 INFO - 'USER': 'cltbld', 02:42:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:26 INFO - '_': '/tools/buildbot/bin/python'} 02:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:26 INFO - Downloading/unpacking psutil>=3.1.1 02:42: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 02:42: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 02:42: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 02:42: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 02:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:27 INFO - Installing collected packages: psutil 02:42:27 INFO - Running setup.py install for psutil 02:42:27 INFO - building 'psutil._psutil_linux' extension 02:42:27 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 02:42:28 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 02:42:28 INFO - building 'psutil._psutil_posix' extension 02:42:28 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 02:42:28 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 02:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:28 INFO - Successfully installed psutil 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:28 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:42:28 INFO - Using env: {'DISPLAY': ':0', 02:42:28 INFO - 'HOME': '/home/cltbld', 02:42:28 INFO - 'LANG': 'en_US.UTF-8', 02:42:28 INFO - 'LANGUAGE': 'en_US:en', 02:42:28 INFO - 'LOGNAME': 'cltbld', 02:42:28 INFO - 'MAIL': '/var/mail/cltbld', 02:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:28 INFO - 'MOZ_NO_REMOTE': '1', 02:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:28 INFO - 'NO_EM_RESTART': '1', 02:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:28 INFO - 'PWD': '/builds/slave/test', 02:42:28 INFO - 'SHELL': '/bin/bash', 02:42:28 INFO - 'SHLVL': '1', 02:42:28 INFO - 'TERM': 'linux', 02:42:28 INFO - 'TMOUT': '86400', 02:42:28 INFO - 'USER': 'cltbld', 02:42:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:28 INFO - '_': '/tools/buildbot/bin/python'} 02:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 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 02:42:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:42:30 INFO - Installing collected packages: mozsystemmonitor 02:42:30 INFO - Running setup.py install for mozsystemmonitor 02:42:30 INFO - Successfully installed mozsystemmonitor 02:42:30 INFO - Cleaning up... 02:42:30 INFO - Return code: 0 02:42:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:42:30 INFO - Using env: {'DISPLAY': ':0', 02:42:30 INFO - 'HOME': '/home/cltbld', 02:42:30 INFO - 'LANG': 'en_US.UTF-8', 02:42:30 INFO - 'LANGUAGE': 'en_US:en', 02:42:30 INFO - 'LOGNAME': 'cltbld', 02:42:30 INFO - 'MAIL': '/var/mail/cltbld', 02:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:30 INFO - 'MOZ_NO_REMOTE': '1', 02:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:30 INFO - 'NO_EM_RESTART': '1', 02:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:30 INFO - 'PWD': '/builds/slave/test', 02:42:30 INFO - 'SHELL': '/bin/bash', 02:42:30 INFO - 'SHLVL': '1', 02:42:30 INFO - 'TERM': 'linux', 02:42:30 INFO - 'TMOUT': '86400', 02:42:30 INFO - 'USER': 'cltbld', 02:42:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:30 INFO - '_': '/tools/buildbot/bin/python'} 02:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:30 INFO - Downloading/unpacking jsonschema==2.5.1 02:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:42: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 02:42: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 02:42: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 02:42: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 02:42:31 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:32 INFO - warning: no files found matching '*.txt' 02:42:32 INFO - no previously-included directories found matching 'build' 02:42:32 INFO - no previously-included directories found matching 'dist' 02:42:32 INFO - no previously-included directories found matching '.git*' 02:42:32 INFO - Installing collected packages: jsonschema, functools32 02:42:32 INFO - Running setup.py install for functools32 02:42:32 INFO - warning: no files found matching '*.txt' 02:42:32 INFO - no previously-included directories found matching 'build' 02:42:32 INFO - no previously-included directories found matching 'dist' 02:42:32 INFO - no previously-included directories found matching '.git*' 02:42:32 INFO - Successfully installed jsonschema functools32 02:42:32 INFO - Cleaning up... 02:42:32 INFO - Return code: 0 02:42:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:42:32 INFO - Using env: {'DISPLAY': ':0', 02:42:32 INFO - 'HOME': '/home/cltbld', 02:42:32 INFO - 'LANG': 'en_US.UTF-8', 02:42:32 INFO - 'LANGUAGE': 'en_US:en', 02:42:32 INFO - 'LOGNAME': 'cltbld', 02:42:32 INFO - 'MAIL': '/var/mail/cltbld', 02:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:32 INFO - 'MOZ_NO_REMOTE': '1', 02:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:32 INFO - 'NO_EM_RESTART': '1', 02:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:32 INFO - 'PWD': '/builds/slave/test', 02:42:32 INFO - 'SHELL': '/bin/bash', 02:42:32 INFO - 'SHLVL': '1', 02:42:32 INFO - 'TERM': 'linux', 02:42:32 INFO - 'TMOUT': '86400', 02:42:32 INFO - 'USER': 'cltbld', 02:42:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:32 INFO - '_': '/tools/buildbot/bin/python'} 02:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:42:32 INFO - Cleaning up... 02:42:32 INFO - Return code: 0 02:42:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 02:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:42:32 INFO - Using env: {'DISPLAY': ':0', 02:42:32 INFO - 'HOME': '/home/cltbld', 02:42:32 INFO - 'LANG': 'en_US.UTF-8', 02:42:32 INFO - 'LANGUAGE': 'en_US:en', 02:42:32 INFO - 'LOGNAME': 'cltbld', 02:42:32 INFO - 'MAIL': '/var/mail/cltbld', 02:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:32 INFO - 'MOZ_NO_REMOTE': '1', 02:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:32 INFO - 'NO_EM_RESTART': '1', 02:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:32 INFO - 'PWD': '/builds/slave/test', 02:42:32 INFO - 'SHELL': '/bin/bash', 02:42:32 INFO - 'SHLVL': '1', 02:42:32 INFO - 'TERM': 'linux', 02:42:32 INFO - 'TMOUT': '86400', 02:42:32 INFO - 'USER': 'cltbld', 02:42:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:32 INFO - '_': '/tools/buildbot/bin/python'} 02:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42: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 02:42: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 02:42: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 02:42: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 02:42:34 INFO - Downloading docopt-0.6.1.tar.gz 02:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:34 INFO - Running setup.py install for blobuploader 02:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:34 INFO - Running setup.py install for requests 02:42:34 INFO - Running setup.py install for docopt 02:42:34 INFO - Successfully installed blobuploader requests docopt 02:42:34 INFO - Cleaning up... 02:42:34 INFO - Return code: 0 02:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:34 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/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:34 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:42:34 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:34 INFO - Using env: {'DISPLAY': ':0', 02:42:34 INFO - 'HOME': '/home/cltbld', 02:42:34 INFO - 'LANG': 'en_US.UTF-8', 02:42:34 INFO - 'LANGUAGE': 'en_US:en', 02:42:34 INFO - 'LOGNAME': 'cltbld', 02:42:34 INFO - 'MAIL': '/var/mail/cltbld', 02:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:34 INFO - 'MOZ_NO_REMOTE': '1', 02:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:34 INFO - 'NO_EM_RESTART': '1', 02:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:34 INFO - 'PWD': '/builds/slave/test', 02:42:34 INFO - 'SHELL': '/bin/bash', 02:42:34 INFO - 'SHLVL': '1', 02:42:34 INFO - 'TERM': 'linux', 02:42:34 INFO - 'TMOUT': '86400', 02:42:34 INFO - 'USER': 'cltbld', 02:42:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:34 INFO - '_': '/tools/buildbot/bin/python'} 02:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 INFO - Running setup.py (path:/tmp/pip-h30bQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:35 INFO - Running setup.py (path:/tmp/pip-udztC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:35 INFO - Running setup.py (path:/tmp/pip-uCHTHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:35 INFO - Running setup.py (path:/tmp/pip-GHks_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:35 INFO - Running setup.py (path:/tmp/pip-oEl6k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:35 INFO - Running setup.py (path:/tmp/pip-t6WAAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:35 INFO - Running setup.py (path:/tmp/pip-XdhL7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:35 INFO - Running setup.py (path:/tmp/pip-vTtjxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:35 INFO - Running setup.py (path:/tmp/pip-ofbdkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:35 INFO - Running setup.py (path:/tmp/pip-QSuA6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:35 INFO - Running setup.py (path:/tmp/pip-nrhAxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:35 INFO - Running setup.py (path:/tmp/pip-KoQft5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:35 INFO - Running setup.py (path:/tmp/pip-ETGCGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 INFO - Running setup.py (path:/tmp/pip-rVzEaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:36 INFO - Running setup.py (path:/tmp/pip-U_kdU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:36 INFO - Running setup.py (path:/tmp/pip-JG16w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:36 INFO - Running setup.py (path:/tmp/pip-__XPwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:36 INFO - Running setup.py install for manifestparser 02:42:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:36 INFO - Running setup.py install for mozcrash 02:42:36 INFO - Running setup.py install for mozdebug 02:42:36 INFO - Running setup.py install for mozdevice 02:42:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:36 INFO - Running setup.py install for mozfile 02:42:36 INFO - Running setup.py install for mozhttpd 02:42:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:36 INFO - Running setup.py install for mozinfo 02:42:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozInstall 02:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozleak 02:42:37 INFO - Running setup.py install for mozlog 02:42:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for moznetwork 02:42:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozprocess 02:42:37 INFO - Running setup.py install for mozprofile 02:42:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozrunner 02:42:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:37 INFO - Running setup.py install for mozscreenshot 02:42:37 INFO - Running setup.py install for moztest 02:42:38 INFO - Running setup.py install for mozversion 02:42:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:38 INFO - Cleaning up... 02:42:38 INFO - Return code: 0 02:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:38 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/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:38 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:42:38 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:38 INFO - Using env: {'DISPLAY': ':0', 02:42:38 INFO - 'HOME': '/home/cltbld', 02:42:38 INFO - 'LANG': 'en_US.UTF-8', 02:42:38 INFO - 'LANGUAGE': 'en_US:en', 02:42:38 INFO - 'LOGNAME': 'cltbld', 02:42:38 INFO - 'MAIL': '/var/mail/cltbld', 02:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:38 INFO - 'MOZ_NO_REMOTE': '1', 02:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:38 INFO - 'NO_EM_RESTART': '1', 02:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:38 INFO - 'PWD': '/builds/slave/test', 02:42:38 INFO - 'SHELL': '/bin/bash', 02:42:38 INFO - 'SHLVL': '1', 02:42:38 INFO - 'TERM': 'linux', 02:42:38 INFO - 'TMOUT': '86400', 02:42:38 INFO - 'USER': 'cltbld', 02:42:38 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:38 INFO - '_': '/tools/buildbot/bin/python'} 02:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:38 INFO - Running setup.py (path:/tmp/pip-Gl0NY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:38 INFO - Running setup.py (path:/tmp/pip-am2Ace-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:38 INFO - Running setup.py (path:/tmp/pip-LB6YFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:38 INFO - Running setup.py (path:/tmp/pip-gN7ilo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:38 INFO - Running setup.py (path:/tmp/pip-ghlfDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:38 INFO - Running setup.py (path:/tmp/pip-S96RWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:38 INFO - Running setup.py (path:/tmp/pip-LUeVvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:38 INFO - Running setup.py (path:/tmp/pip-Ujmu8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:38 INFO - Running setup.py (path:/tmp/pip-spbFk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:38 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)) 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:39 INFO - Running setup.py (path:/tmp/pip-EBxfi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:39 INFO - Running setup.py (path:/tmp/pip-kJbaUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:39 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:39 INFO - Running setup.py (path:/tmp/pip-kfKfwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:39 INFO - Running setup.py (path:/tmp/pip-NoDTFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:39 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:39 INFO - Running setup.py (path:/tmp/pip-l8hycH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:39 INFO - Running setup.py (path:/tmp/pip-WkQ5T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:39 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:39 INFO - Running setup.py (path:/tmp/pip-LaMHZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:39 INFO - Running setup.py (path:/tmp/pip-T6olNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:39 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)) 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:42:39 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)) 02:42:39 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:42:39 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:42:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42: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 02:42: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 02:42: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 02:42: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 02:42:40 INFO - Downloading blessings-1.6.tar.gz 02:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:40 INFO - Installing collected packages: blessings 02:42:40 INFO - Running setup.py install for blessings 02:42:40 INFO - Successfully installed blessings 02:42:40 INFO - Cleaning up... 02:42:40 INFO - Return code: 0 02:42:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:41 INFO - Reading from file tmpfile_stdout 02:42:41 INFO - Current package versions: 02:42:41 INFO - argparse == 1.2.1 02:42:41 INFO - blessings == 1.6 02:42:41 INFO - blobuploader == 1.2.4 02:42:41 INFO - docopt == 0.6.1 02:42:41 INFO - functools32 == 3.2.3-2 02:42:41 INFO - jsonschema == 2.5.1 02:42:41 INFO - manifestparser == 1.1 02:42:41 INFO - mozInstall == 1.12 02:42:41 INFO - mozcrash == 1.0 02:42:41 INFO - mozdebug == 0.1 02:42:41 INFO - mozdevice == 0.51 02:42:41 INFO - mozfile == 1.2 02:42:41 INFO - mozhttpd == 0.7 02:42:41 INFO - mozinfo == 0.9 02:42:41 INFO - mozleak == 0.1 02:42:41 INFO - mozlog == 3.4 02:42:41 INFO - moznetwork == 0.27 02:42:41 INFO - mozprocess == 0.25 02:42:41 INFO - mozprofile == 0.28 02:42:41 INFO - mozrunner == 6.13 02:42:41 INFO - mozscreenshot == 0.1 02:42:41 INFO - mozsystemmonitor == 0.3 02:42:41 INFO - moztest == 0.8 02:42:41 INFO - mozversion == 1.4 02:42:41 INFO - psutil == 3.1.1 02:42:41 INFO - requests == 1.2.3 02:42:41 INFO - wsgiref == 0.1.2 02:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:41 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/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:41 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:42:41 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:41 INFO - Using env: {'DISPLAY': ':0', 02:42:41 INFO - 'HOME': '/home/cltbld', 02:42:41 INFO - 'LANG': 'en_US.UTF-8', 02:42:41 INFO - 'LANGUAGE': 'en_US:en', 02:42:41 INFO - 'LOGNAME': 'cltbld', 02:42:41 INFO - 'MAIL': '/var/mail/cltbld', 02:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:41 INFO - 'MOZ_NO_REMOTE': '1', 02:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:41 INFO - 'NO_EM_RESTART': '1', 02:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:41 INFO - 'PWD': '/builds/slave/test', 02:42:41 INFO - 'SHELL': '/bin/bash', 02:42:41 INFO - 'SHLVL': '1', 02:42:41 INFO - 'TERM': 'linux', 02:42:41 INFO - 'TMOUT': '86400', 02:42:41 INFO - 'USER': 'cltbld', 02:42:41 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:41 INFO - '_': '/tools/buildbot/bin/python'} 02:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 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)) 02:42:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:42:42 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)) 02:42:42 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)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:42:42 INFO - Installing collected packages: marionette-driver 02:42:42 INFO - Running setup.py install for marionette-driver 02:42:42 INFO - Successfully installed marionette-driver 02:42:42 INFO - Cleaning up... 02:42:42 INFO - Return code: 0 02:42:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', '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 02:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:42:42 INFO - Using env: {'DISPLAY': ':0', 02:42:42 INFO - 'HOME': '/home/cltbld', 02:42:42 INFO - 'LANG': 'en_US.UTF-8', 02:42:42 INFO - 'LANGUAGE': 'en_US:en', 02:42:42 INFO - 'LOGNAME': 'cltbld', 02:42:42 INFO - 'MAIL': '/var/mail/cltbld', 02:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:42 INFO - 'MOZ_NO_REMOTE': '1', 02:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:42 INFO - 'NO_EM_RESTART': '1', 02:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:42 INFO - 'PWD': '/builds/slave/test', 02:42:42 INFO - 'SHELL': '/bin/bash', 02:42:42 INFO - 'SHLVL': '1', 02:42:42 INFO - 'TERM': 'linux', 02:42:42 INFO - 'TMOUT': '86400', 02:42:42 INFO - 'USER': 'cltbld', 02:42:42 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:42 INFO - '_': '/tools/buildbot/bin/python'} 02:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:42 INFO - Cleaning up... 02:42:42 INFO - Return code: 0 02:42:42 INFO - Running post-action listener: _resource_record_post_action 02:42:42 INFO - Running post-action listener: _start_resource_monitoring 02:42:42 INFO - Starting resource monitoring. 02:42:42 INFO - [mozharness: 2017-05-26 09:42:42.913488Z] Finished create-virtualenv step (success) 02:42:42 INFO - [mozharness: 2017-05-26 09:42:42.914003Z] Running install step. 02:42:42 INFO - Running pre-action listener: _resource_record_pre_action 02:42:42 INFO - Running main action method: install 02:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:43 INFO - Reading from file tmpfile_stdout 02:42:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:43 INFO - Reading from file tmpfile_stdout 02:42:43 INFO - Output received: 02:42:43 INFO - Usage: mozinstall [options] installer 02:42:43 INFO - Options: 02:42:43 INFO - -h, --help show this help message and exit 02:42:43 INFO - -d DEST, --destination=DEST 02:42:43 INFO - Directory to install application into. [default: 02:42:43 INFO - "/builds/slave/test"] 02:42:43 INFO - --app=APP Application being installed. [default: firefox] 02:42:43 INFO - mkdir: /builds/slave/test/build/application 02:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:42:59 INFO - Reading from file tmpfile_stdout 02:42:59 INFO - Output received: 02:42:59 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:59 INFO - Running post-action listener: _resource_record_post_action 02:42:59 INFO - [mozharness: 2017-05-26 09:42:59.258279Z] Finished install step (success) 02:42:59 INFO - [mozharness: 2017-05-26 09:42:59.258552Z] Running run-tests step. 02:42:59 INFO - Running pre-action listener: _resource_record_pre_action 02:42:59 INFO - Running main action method: run_tests 02:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:59 INFO - Python 2.7.3 02:42:59 INFO - Return code: 0 02:42:59 INFO - grabbing minidump binary from tooltool 02:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:59 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b17a0>, '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 0x27b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b2b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:59 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 02:42:59 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 02:42:59 INFO - Calling ['/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'] with output_timeout 600 02:42:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:59 INFO - Return code: 0 02:42:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - ENV: RUST_BACKTRACE is now 1 02:42:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:42:59 INFO - Using env: {'DISPLAY': ':0', 02:42:59 INFO - 'HOME': '/home/cltbld', 02:42:59 INFO - 'LANG': 'en_US.UTF-8', 02:42:59 INFO - 'LANGUAGE': 'en_US:en', 02:42:59 INFO - 'LOGNAME': 'cltbld', 02:42:59 INFO - 'MAIL': '/var/mail/cltbld', 02:42:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:59 INFO - 'MOZ_NO_REMOTE': '1', 02:42:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:59 INFO - 'NO_EM_RESTART': '1', 02:42:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:59 INFO - 'PWD': '/builds/slave/test', 02:42:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:59 INFO - 'RUST_BACKTRACE': '1', 02:42:59 INFO - 'SHELL': '/bin/bash', 02:42:59 INFO - 'SHLVL': '1', 02:42:59 INFO - 'TERM': 'linux', 02:42:59 INFO - 'TMOUT': '86400', 02:42:59 INFO - 'USER': 'cltbld', 02:42:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786', 02:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:59 INFO - '_': '/tools/buildbot/bin/python'} 02:42:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:42:59 INFO - mozversion application_buildid: 20170526090427 02:42:59 INFO - mozversion application_changeset: bedd24174ff464c4318db7224aa47ba84c25abec 02:42:59 INFO - mozversion application_display_name: Nightly 02:42:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:59 INFO - mozversion application_name: Firefox 02:42:59 INFO - mozversion application_remotingname: firefox 02:42:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:42:59 INFO - mozversion application_vendor: Mozilla 02:42:59 INFO - mozversion application_version: 55.0a1 02:42:59 INFO - mozversion platform_buildid: 20170526090427 02:42:59 INFO - mozversion platform_changeset: bedd24174ff464c4318db7224aa47ba84c25abec 02:42:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:42:59 INFO - mozversion platform_version: 55.0a1 02:42:59 INFO - using testdate: 1495791779 02:42:59 INFO - actual date: 1495791779 02:42:59 INFO - starting webserver on 'localhost:55482' 02:42:59 INFO - SUITE-START | Running 2 tests 02:42:59 INFO - TEST-START | dromaeo_css 02:42:59 INFO - operating with platform_type : linux_ 02:42:59 INFO - Initialising browser for dromaeo_css test... 02:42:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55482/getInfo.html -profile /tmp/tmpwmqrBs/profile 02:42:59 INFO - TEST-INFO | started process 12966 (/builds/slave/test/build/application/firefox/firefox http://localhost:55482/getInfo.html) 02:43:34 INFO - TEST-INFO | 12966: killed by SIGTERM 02:43:35 INFO - Browser initialized. 02:43:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:43:35 INFO - TEST-INFO | started process 13187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmqrBs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:47 INFO - PID 13187 | RSS: Main: 172703744 02:43:47 INFO - PID 13187 | 02:46:51 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55482/tests/dromaeo/cssquery-ext.html) 02:46:53 INFO - PID 13187 | RSS: Main: 170237952 02:46:53 INFO - PID 13187 | 02:49:55 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-ext.html (next: http://localhost:55482/tests/dromaeo/cssquery-jquery.html) 02:49:56 INFO - PID 13187 | RSS: Main: 176521216 02:49:56 INFO - PID 13187 | 02:52:57 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55482/tests/dromaeo/cssquery-mootools.html) 02:52:58 INFO - PID 13187 | RSS: Main: 174166016 02:52:58 INFO - PID 13187 | 02:56:00 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55482/tests/dromaeo/cssquery-prototype.html) 02:56:01 INFO - PID 13187 | RSS: Main: 178933760 02:56:01 INFO - PID 13187 | 02:59:03 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55482/tests/dromaeo/cssquery-yui.html) 02:59:04 INFO - PID 13187 | RSS: Main: 177807360 02:59:04 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-yui.html (next: http://localhost:55482/tests/dromaeo/cssquery-dojo.html) 03:02:06 INFO - PID 13187 | RSS: Main: 175185920 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | __start_tp_report 03:02:06 INFO - PID 13187 | _x_x_mozilla_page_load 03:02:06 INFO - PID 13187 | _x_x_mozilla_page_load_details 03:02:06 INFO - PID 13187 | |i|pagename|runs| 03:02:06 INFO - PID 13187 | |0;dojo.html;2716.82340647858;2722.1153125234296;2747.3131717070733;2777.0835624243996;2779.277387879151;5230.372355317368;5388.137897936331;5392.4068352481245;5432.293801805765;5439.0209762242785;5273.2617433559335;5304.734763261831;5357.812476563321;5388.191771234317;5435.619506634537;4747.881302967437;4771.117343291502;4803.639727020462;4814.205656066745;4828.97585512072;4743.217369134089;4794.616430685537;4844;4847.587955023827;4903.2645103234445;4646.303054541846;4685.344051832746;4788.377510923558;4796.616270698336;4841.273808928671;4757.619390448755;4759.904801903943;4814.446338671062;4826.855194344175;4827.203511420611;4744.217204161309;4756.143894099061;4764.976175119137;4769.2607645814605;4811.061842940628;5147.433782283946;5309.787608495655;5331.546818520392;5335.413104558495;5356.892862142735;5688.061469857468;5711.514521265697;5722.799702010451;5801.390853960315;5830.0380437227805;5839.678817665027;5850.3272123705465;5851.590388672795;5854.912176317359;5910.763569457216;5373.059714550016;5384.67691938481;5401.972990135024;5406.702631355313;5419.539339156216;5761.942380576224;5828.6502809831545;5838.737256823453;5935.465808077208;5960.225170727777;5600.299962504687;5660.773569057274;5679.517241034476;5693;5710.486056254957;5600.803971860965;5696.914546281809;5712.171735098387;5718.571107166979;5728.742206600713;5581.5813813963305;5668.206451096849;5682.318121825325;5697.4302569742695;5698.401667824902;5665.971670141623;5741.052726300114;5764.481196692318;5771.682557459296;5772;4508.639308855284;4518.254488009507;4524.864254072383;4547.590716835501;4563.361129441881;3859.671927886105;3870.303345397799;3872.244912242142;3900.1029763154634;3915.060385507458;4750.358701575312;4808.2547205183255;4815.2054910940005;4844.055409195244;4892.68197567157;5736.971315143398;5763.510101641324;5778.566607504454;5785.88428231433;5832.416758324133;4831.323614693945;4850.442199147144;4851.417829860439;4859.2954021666665;4894.339264199359;4930.383702037246;5011.599072074152;5061.164907790173;5074.035933172685;5079.72061536619;5277.894442111213;5321.494458026481;5337.252784610236;5363.222332761806;5375.1131063374105;5593.664380137205;5694.4590263924865;5773.769049237983;5818.970905145447;5820.679862607428;5268.1834315681135;5303.655262407931;5305.442928492453;5352.116900711339;5409.1345384739825;5578.944210557843;5704.885902281848;5710.914336284876;5727.599068065362;5735.197072409783;5671.262735844314;5746.9712651436475;5757.5681823864215;5796.8550786229;5836.095405212199;5548.750306236309;5581.051221292471;5582.3859375467855;5611.102223644198;5665.348484924287;5553.750081246273;5557.277553917965;5560.138178582326;5565.332160140809;5611.130274807411;5449.2371068049715;5481.260029895913;5494.7802087917635;5499.9175012375645;5500.092484739973;5515.420880807457;5583.508036338322;5606.579506536945;5628.043232650377;5679.659220446786;5512.118061110203;5538.501534861882;5545.057340252086;5565.554755619622;5570.2480165177185 03:02:06 INFO - PID 13187 | |1;ext.html;656.7274581048865;721.7509959064123;742.5396254322319;1035.099463466784;1059.4437920091946;33187.50218746721;34016.65983340166;34258.8287058565;34264.82867585665;34323.82838085809;35783.821080894624;35949;36263;36310.09224769382;36378.09054773632;6849.1096157499705;6914.3777060064585;7015.4036906862975;7065.717371305142;7088.149422069333;6948.617826019567;7001.789946301619;7034.613096279702;7049.788506344792;7055.223925368231;7026.208316879214;7026.332498412668;7026.683799229021;7034.472414568902;7086;7005.754798582051;7046.7533636323;7061.788146355618;7065.682044307992;7067.505274630778;6898.241193468714;6919.827004324882;6925.065116209297;6937.861242775116;6981.685824137926;33570.32859342799;33799.324013519836;34051.82974085138;34070.65929340725;34129.14677133067;3059.1128572713887;3098.9690103098906;3103.1001009707156;3115.143335582733;3120.0483852425;25138.371540711447;25262.873685631454;25289;25310.746892531206;25329.366765831;2945;2950.8524573771224;2955.733983941434;2963.5554666799935;2972.8662210200378;150580;151122;157077;160620.19689901476;161253;40812;40824.387634185514;40989;41019.58980410217;41109.38335924964;42147;42258.78870605627;42268.15463690709;42284;42375.491186145606;12801.551945682042;12819.35903204836;12950.287734174522;12977.675558110934;12978.286194259217;10420.32267902584;10527.842082368617;10537.84193237102;10544.416617928657;10578.365298082139;12860.228386296852;12925.353732313346;12977;13021.739565208643;13054.738905221842;5179.637425380187;5341.519263266325;5403.5136837684795;5409.134538473825;5420.403755586883;826.5412695953803;896.9416987895765;904.8778414913902;906.7959709065408;912.2519533982204;20986.969919442152;21442.678359824615;21577.24479643205;21758.129674813146;21943.341699749035;983.7983213441228;989.7327721515151;1005.7183988483237;1006.1045669354135;1006.2918146629693;11275.097992160607;11400.94299528497;11576.76846463066;11630.6510804676;11674.124440666985;178738;180790.09604952155;180819;181078;181349;41794.49233046027;41963.37054944178;42023;42074;42145.78927105345;1216.2702378572785;1257.0132446029822;1259.911806173559;1263.4270333434931;1268.9936550317188;19658.60682786365;19922;20236;21503.677444838027;21527.8923605381;30133.246668833453;30355.544666830458;30368.69631303747;30384.240393990327;30434;150405.24797375943;151420.07249093862;151767.2411637935;151769;152699;29662.555061673662;30053;30117.849410753683;30300.272975432315;30331.545026825057;36618.26763464769;36662.8166859164;36805.63194368129;36891.446628301135;37189.62810371862;25482.399603371345;26733.598996014687;27086.1874143776;27701.722982769916;28222.85888570544;25732.742672573782;27093.593596096467;27237.72762272352;28090.578641320804;28457;30784.384312314076;30939.84530077335;31028.844855775576;31074;31103.377932440773;25958.610620840325;26635.7336426641;26650.333741656614;26928.73071269262;27328.590071149345;20017.6997345037;22251;22369.77925996465;22625.2081177158;22657.773422265567 03:02:06 INFO - PID 13187 | |2;jquery.html;418.5688740597184;422.82875435448653;427.33335995846494;433.83080598566556;440.1087797210648;14144.78782818256;14589.781153282709;17130.48608541744;17914.014729189905;18043.097845107743;18842.71735923962;19000.429987100375;19187.32844350448;19327.710084348746;19401.223951041942;5435.809746658868;5443.591730620199;5454.072807622713;5607.43925607438;5623.156526521014;5425.26758887551;5561.63849349791;5568.1091025435935;5569.777208911639;5573.442655734435;4961.826336078238;5342.839714808562;5356.651817631841;5365.7853685852715;5549.278593782803;5381.838544843661;5401.675899446046;5404.7838086476495;5412.702301373423;5414.35027796665;4880.438749543812;4940.530649588283;4946.282788995612;4955.653104282702;4980.128477516457;21742.45643858916;21885.234016809336;22006.669899951514;22080.2271920482;22106.778932210633;1608.4450864451862;1647.7693122962794;1649.8845080844346;1660.8256133106092;1662.742274947385;13988.090774099652;14333.283335833166;14796.18620975846;14934.402623895032;14938.477153299691;2050.5796311756053;2053.065855035955;2086.228095604636;2101.642720737478;2107.1782005018053;71038.64480677563;83869.58065209635;86572.56713716454;86599.5670021646;88367.55816220878;10841.457927103613;10916.524225067684;11110.777934370833;11121.16591255643;11383.373914434786;15807.841921580866;15883;15919.920400397923;15991.040537567784;16017.759733604005;7468.290512401313;7502.511332230539;7683.538987660758;7716.6527506262355;7718.498297610638;6827.283135270725;6883.586984780929;7068.787936361918;7080.858382832314;7081.539699919489;6937.653117344214;6939.167299924042;6955.443564514827;7071.36357727807;7104.786856394317;1991.2134706791026;2026.8277196438173;2040.2960978462406;2071.440711008019;2183.3013435700423;827.9461834980707;847.220557087481;874.7638137702785;888.8711136885245;889.5063239901788;16568.502944911674;16616.086115263533;16980.150992450574;17188.570285742706;17194.398196063077;871.107115206918;884.5533005832142;893.1381217125376;903.051795614602;906.4017748286232;9068.319876009326;9163.58763855628;9275.397099188665;10896.618618348479;11868.465919033664;356360;360780;362950;363109;372913;72913;74065.62967185129;75560;76566;77642;1051.3796859852876;1066.2673156121302;1096.3476731344838;1110.4669758515959;1114.4594871487323;17114.48656540306;17382.391616293367;17541.21064552073;18040.2783888643;18227;38548.80725596354;38729;38861.8056909725;39396.2120757589;40274;48192.759036206;49213.753931230116;49439.752801235765;50213.74893125511;50791;7991;8015.318697910743;8034;8037.517748935083;8480.95759521223;11834.704132396759;11924;12042.21725587834;12300.261984280973;12596.244225346509;10273.02406271403;10561.313514621525;10663;10726.356418614909;10920.071793897609;9301.674441394789;9539;9555.331126821335;9658.647789309362;9885.604575816888;10642.361458312216;10780.191485638765;10789.082927951213;10883.183761218099;11094.00153986145;8062.717804876801;8177.914631769098;8189.918100818915;8192.426530142833;8234.423590348619;10062.647807326708;10235.539400727133;10372.740681483023;10403;10827 03:02:06 INFO - PID 13187 | |3;mootools.html;1263.9936800316;1329.155985948922;1330.068951733786;1330.9201447913126;1344.6839992601738;10129;10602.310849794758;10602.78794424112;10610.78778424431;10901.727456813584;9999;10147.340422872508;10158.1873450124;10168.44073575953;10195.4392508412;2200.130948275434;2233.2406981626245;2243.741969673484;2246.168917500527;2248.6627005949076;2161.9243326483574;2202.5484775620957;2218.4010317214343;2221.178164079293;2224.5773303072447;1907.122723547163;1942.9805701942942;1946.0561627610598;1955.1104247567323;1956.3739603326942;2118;2128.70198172256;2132.4349047502346;2137.1344605434824;2138.518833262511;1893.867429279951;2016.828569571588;2069.813716765483;2131.26471367378;2131.4245153808383;10319.793604127875;10408.167346612252;10412.219083568687;10414.479276036167;10415.583376665;5430.6741595504;5634.943650563483;5636.464535869086;5637.436256374371;5638.069718496443;3190.457622204231;3334.433146365124;3393.898183054512;3397.13373089863;3411.0449074259245;1067.6583493282153;1090.6727981605566;1094.9069329107035;1103.862017247844;1110.3337997201695;15180.316885740169;15213.543593692208;15337.77602247679;15384.923075384551;15448.459303924308;4551.3173024046;4572.8399506017795;4786.688865223749;4802.639802014863;4844.612431005511;11017.504212310465;11021.83467247992;11026.574153686177;11033.83449248262;11053.17101217412;5419.972900135474;5536.8062117826485;5539.086050801653;5547.55619550435;5560.332760068818;5098.770555325019;5160.148575485078;5161.200013997836;5176.844694659091;5181.326427564392;3824.9426258606145;3848.191879705237;3908.257431088084;3911.2959667259597;3963.8810835674976;1036.7149034015706;1042.5360714482135;1059.692689120162;1063.3194755356578;1066.2376400873413;712.1454254894147;742.5396254322354;743.84007438401;751.549070557661;759.4911409355744;5606.831795046155;5664.745086471119;5708.543316534668;5732.16883551891;5765.279340082489;547.0918275662382;575.1344226938431;576.1156624581248;579.0850456279153;822.1039067416544;4022.155347377025;4043.454133691973;4076.4496792932573;4097.631213190827;4206.705530612828;13672.863271367358;13903.4438622456;14137.646558835906;14147.434102635985;14211.147331160164;13885.236312002937;13920.095193812369;13921.164730116225;13928.233947132801;14011.71976560463;6878.174619045646;7283.235260297804;7289.271072892774;7359.816004599821;7452.552846829208;6291.370862913672;6495.350464953467;6500.349965003462;6540.738370465128;6694.297098804555;12159.513619455123;12350.135490515577;12519.56181533642;12530.934870535742;12713.8092928608;12166.878331216929;12226.266424014588;12536.498540058295;12542.874571254535;12719.87280127187;9632.662856799978;9896.802063958536;9898.950505247716;9946.55240514193;9962.50187490608;9353.812923741623;9663.13031827139;9749.463779492196;9757.21942244633;9815.950920245354;8073.950386449724;8278.675411934062;8287.088420273645;8327.54198519063;8352.916470835215;7821.765347039598;7993.1607181247455;8107.351411886917;8238.423310368216;8414.873776893473;7684.231576842271;7729.961350193213;7766.106897706836;7771.494852834548;7777.144514103557;5250.579953603627;5305.363356397257;5345.091334473072;5586.329640443173;5758.481736643722;5591.384947655836;5665.801696940587;5671.574631902541;5731.054376027909;5821.621594596338 03:02:06 INFO - PID 13187 | |4;prototype.html;360.11950780342056;375.3131768862981;380.6060727147403;384.22578504313793;387.5330227076373;5433.4566543345645;5615.66306021639;5623.381428042912;5643.3036361183495;5651.3218413790355;5409.540189083933;5551.1673249012665;5553.694546799924;5557.110862262039;5585.301837270341;4393.05549306899;4399.824007039714;4402.635183093252;4405.096955124208;4412.205802955466;4354.956450435503;4375.387445757597;4406.823727050914;4412.492563355223;4420.07178492517;4372.6283265922275;4376.474823021242;4380.167768124046;4399.472063352387;4402.625776808975;4322.6325762309925;4330.631896288819;4331.581786577704;4331.826726930919;4354.629856462205;3923.097687531884;3977.840886364571;3978.5225772907147;4005.419214213952;4015.3976903464422;5444.428335024805;5451.792024230153;5471.616986810925;5483.259759932438;5537.58468114893;5211;5217.895642087137;5245.606579506552;5248.396434410053;5255.316808814868;5753.194552762617;5867.002609556343;5914.2015827863115;5948.464638182541;5958.165856780054;4462.419885414908;4471.690948697973;4484.596386325246;4493.348464472666;4500.662450316239;5969.611975221596;6137.508999280091;6159.137720719103;6169.629822210637;6219.253689557237;4316.136772645484;4323.718958267703;4335.154644844225;4337.110892267077;4338.197433474817;4393.362962370502;4396.428464299621;4397.274449715761;4398.208322501916;4426.911461770746;4960.751962401865;4976.377952755905;4997.750112494361;5146.099432599281;5188.818391356284;5905.940940590625;5909.172715819789;5922.49658779;5939.792107276311;5942.286925568959;1604.6549991751829;1628.202180931335;1633.901965882051;1637.3368785641835;1638.3119089982235;1153.9307641541366;1174.6652204121956;1175.2713317743055;1181.4033912874115;1194.5102507971865;5044.672096313728;5062.114130027304;5068.594512438996;5080.13637681595;5088.211327244283;6051.789642071603;6074.149619053336;6075.817725468243;6085.57400981927;6106.603070800384;4844.709317440965;4953.67801092935;4995.400551933792;5000.74996250186;5004.874878128003;3150.826704531227;3178.1714274295896;3228.1122691260093;3229.531717900891;3238.6923242291946;5533.529649979716;5577.498025177753;5596.3284405870745;5607.467290607386;5640.520555752807;6141.140240366352;6181.721822517908;6204.069389591597;6207.255129384413;6217.906731399033;5554.895790036266;5606.467385598362;5616.97191514048;5652.97173514138;5653.208550802891;5948.345681974893;6016.127661488972;6042.788502402394;6053.243344581927;6081.483073938764;5718.51392631631;5960.761569537343;5980.102984552352;5999.5500337473995;6004.42957918997;5543.861403464784;5575.832725018256;5584.832455026356;5595.216669666169;5598.916016259678;4071.592840715905;4115.629593336614;4117.279476091732;4121.752694838319;4123.237201117803;5887.087501437284;6024.698765061817;6026.909596356146;6095.3904609538695;6096.75612975476;5843.211166492469;5872.588918775645;5878.617889837147;5912.586118971631;5920.733566989582;5809;5835;5862.739511005155;5878.823635290948;5879.617824841372;5719.5138413235345;5722.113072473773;5760.654360738369;5770.538356931352;5800.854978625568;5834.795782147605;5846.883062338644;5879.176915231957;5894.2926848778425;5896.705164741831;5586.497215250647;5677.984315567914;5679.8864022720145;5710;5717.685527296038 03:02:06 INFO - PID 13187 | |5;yui.html;685.417395214068;689.6930865764733;697.884848999915;746.4811955690797;770.9999999999997;11991.340476273801;12496.812547811767;13476.25880576568;14104.858951410495;14127.505537306197;15199;15818.367265309374;15842.920785396085;15878.761818572702;15930.203489825491;885.4023534114463;903.0157128729684;906.7642412972641;907.2061945797427;907.4101833808012;916.3997581584073;917.1149840404008;917.3899356927635;919.103873723118;921.1801496667971;967.0377973915963;971.9951400242988;976.9902300977005;978.149010360987;978.6721448314823;953.3469573342248;960.7886265021684;964.045594861086;964.1130160252584;965.5413678502655;684.8732984397902;686.3376841348123;689.2556039477353;689.6310473896441;691.239636399961;14767.409303627843;14907;14937.17845518496;14938.477153299582;14945.551633451014;15802.209889505479;15998.52004439857;16230.350785968547;16234.188290585542;16270.511884643362;12719;12980.740385192337;13104.410301536454;13251.536196233183;13253;2947.101134154082;2947.1453278549193;2955.3793703322326;2961.570572267031;2970.866311015988;76213.61893190499;76214.23785762126;76256.23743762547;76964;77020.61489692572;11120.721981950515;11314;11330.263532870336;11372.374519401346;11389.715257118638;17983;18156.63686726258;18245.08774561293;18325.7251141233;18652.160652770657;6318.936810631927;6412.038194270804;6413.166288382574;6416.133821934072;6417.069524918954;3023.7580993520905;3072.4776787946103;3087.598612180402;3088.5521599367967;3096.442640324718;3634.6910512606723;3669.43123815809;3690.7785532868115;3699.8520059197867;3739.2521495700967;586.2905883880467;595.7616953218748;735.1362149474346;764.5221736414741;764.9426293028046;585.5520526797004;593.2199158107076;600.5885968111858;601.9668918209453;621.1707370660129;10068.39589624625;10714.73213169677;10945.781084378426;11182.888171118348;11350.659480215607;562.1118632560544;571.5656101362994;574;581.6975172910063;583.2359608912338;4812.51874812516;4830.275458681226;4832.782524786393;4890;4995.725235112031;83805.58097209597;83992;85907;86060.56969715112;86601;73549;74647.62676186585;75002;75154.24845751582;76437.61781191059;65103;65390;65413.67293163504;66065;67657.32342676609;9189.402688825205;9852.802943940938;9912.702618921443;9934.254930880068;9951.800963980535;28957.525096988495;29023.41953160967;29123.85438072796;29491;30311.848440757654;38012.61987380202;38107.618923810405;38238.42642360311;38960.41559376555;39038.6096139035;12309;12318.876811231772;12389.380530973596;12455.813162802746;12464.626061218178;13546.86453135456;13638.727225455237;13697.109687870257;13740.862591374358;13933.58199254024;12695;12962.611121666365;13336;14190.57428277112;14535.418583256975;13051.934740326238;13585.388657510239;13930.373133209232;14205.502807401692;14239.715205696035;13305.135166214164;13638.522651707142;13971.441142354191;13974.650633734238;14100.929495352457;11076.723081923017;11108.944455277671;11228.606998755004;11394.772104557696;11453.427328633701;12305.876941230474;12736.6815829605;12858.742825143632;12861.935690321863;12875.549355772502 03:02:06 INFO - PID 13187 | __end_tp_report 03:02:06 INFO - PID 13187 | __start_cc_report 03:02:06 INFO - PID 13187 | _x_x_mozilla_cycle_collect,356 03:02:06 INFO - PID 13187 | __end_cc_report 03:02:06 INFO - PID 13187 | __startTimestamp1495792926596__endTimestamp 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | ------- Summary: start ------- 03:02:06 INFO - PID 13187 | Number of tests: 6 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#0] dojo.html Cycles:165 Average:5239.94 Median:5432.29 stddev:641.25 (11.8%) stddev-sans-first:611.91 03:02:06 INFO - PID 13187 | Values: 2716.8 2722.1 2747.3 2777.1 2779.3 5230.4 5388.1 5392.4 5432.3 5439.0 5273.3 5304.7 5357.8 5388.2 5435.6 4747.9 4771.1 4803.6 4814.2 4829.0 4743.2 4794.6 4844.0 4847.6 4903.3 4646.3 4685.3 4788.4 4796.6 4841.3 4757.6 4759.9 4814.4 4826.9 4827.2 4744.2 4756.1 4765.0 4769.3 4811.1 5147.4 5309.8 5331.5 5335.4 5356.9 5688.1 5711.5 5722.8 5801.4 5830.0 5839.7 5850.3 5851.6 5854.9 5910.8 5373.1 5384.7 5402.0 5406.7 5419.5 5761.9 5828.7 5838.7 5935.5 5960.2 5600.3 5660.8 5679.5 5693.0 5710.5 5600.8 5696.9 5712.2 5718.6 5728.7 5581.6 5668.2 5682.3 5697.4 5698.4 5666.0 5741.1 5764.5 5771.7 5772.0 4508.6 4518.3 4524.9 4547.6 4563.4 3859.7 3870.3 3872.2 3900.1 3915.1 4750.4 4808.3 4815.2 4844.1 4892.7 5737.0 5763.5 5778.6 5785.9 5832.4 4831.3 4850.4 4851.4 4859.3 4894.3 4930.4 5011.6 5061.2 5074.0 5079.7 5277.9 5321.5 5337.3 5363.2 5375.1 5593.7 5694.5 5773.8 5819.0 5820.7 5268.2 5303.7 5305.4 5352.1 5409.1 5578.9 5704.9 5710.9 5727.6 5735.2 5671.3 5747.0 5757.6 5796.9 5836.1 5548.8 5581.1 5582.4 5611.1 5665.3 5553.8 5557.3 5560.1 5565.3 5611.1 5449.2 5481.3 5494.8 5499.9 5500.1 5515.4 5583.5 5606.6 5628.0 5679.7 5512.1 5538.5 5545.1 5565.6 5570.2 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#1] ext.html Cycles:180 Average:30960.80 Median:30343.54 stddev:42128.53 (138.8%) stddev-sans-first:42185.26 03:02:06 INFO - PID 13187 | Values: 656.7 721.8 742.5 1035.1 1059.4 33187.5 34016.7 34258.8 34264.8 34323.8 35783.8 35949.0 36263.0 36310.1 36378.1 6849.1 6914.4 7015.4 7065.7 7088.1 6948.6 7001.8 7034.6 7049.8 7055.2 7026.2 7026.3 7026.7 7034.5 7086.0 7005.8 7046.8 7061.8 7065.7 7067.5 6898.2 6919.8 6925.1 6937.9 6981.7 33570.3 33799.3 34051.8 34070.7 34129.1 3059.1 3099.0 3103.1 3115.1 3120.0 25138.4 25262.9 25289.0 25310.7 25329.4 2945.0 2950.9 2955.7 2963.6 2972.9 150580.0 151122.0 157077.0 160620.2 161253.0 40812.0 40824.4 40989.0 41019.6 41109.4 42147.0 42258.8 42268.2 42284.0 42375.5 12801.6 12819.4 12950.3 12977.7 12978.3 10420.3 10527.8 10537.8 10544.4 10578.4 12860.2 12925.4 12977.0 13021.7 13054.7 5179.6 5341.5 5403.5 5409.1 5420.4 826.5 896.9 904.9 906.8 912.3 20987.0 21442.7 21577.2 21758.1 21943.3 983.8 989.7 1005.7 1006.1 1006.3 11275.1 11400.9 11576.8 11630.7 11674.1 178738.0 180790.1 180819.0 181078.0 181349.0 41794.5 41963.4 42023.0 42074.0 42145.8 1216.3 1257.0 1259.9 1263.4 1269.0 19658.6 19922.0 20236.0 21503.7 21527.9 30133.2 30355.5 30368.7 30384.2 30434.0 150405.2 151420.1 151767.2 151769.0 152699.0 29662.6 30053.0 30117.8 30300.3 30331.5 36618.3 36662.8 36805.6 36891.4 37189.6 25482.4 26733.6 27086.2 27701.7 28222.9 25732.7 27093.6 27237.7 28090.6 28457.0 30784.4 30939.8 31028.8 31074.0 31103.4 25958.6 26635.7 26650.3 26928.7 27328.6 20017.7 22251.0 22369.8 22625.2 22657.8 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#2] jquery.html Cycles:180 Average:24487.07 Median:39835.11 stddev:60365.78 (151.5%) stddev-sans-first:60508.07 03:02:06 INFO - PID 13187 | Values: 418.6 422.8 427.3 433.8 440.1 14144.8 14589.8 17130.5 17914.0 18043.1 18842.7 19000.4 19187.3 19327.7 19401.2 5435.8 5443.6 5454.1 5607.4 5623.2 5425.3 5561.6 5568.1 5569.8 5573.4 4961.8 5342.8 5356.7 5365.8 5549.3 5381.8 5401.7 5404.8 5412.7 5414.4 4880.4 4940.5 4946.3 4955.7 4980.1 21742.5 21885.2 22006.7 22080.2 22106.8 1608.4 1647.8 1649.9 1660.8 1662.7 13988.1 14333.3 14796.2 14934.4 14938.5 2050.6 2053.1 2086.2 2101.6 2107.2 71038.6 83869.6 86572.6 86599.6 88367.6 10841.5 10916.5 11110.8 11121.2 11383.4 15807.8 15883.0 15919.9 15991.0 16017.8 7468.3 7502.5 7683.5 7716.7 7718.5 6827.3 6883.6 7068.8 7080.9 7081.5 6937.7 6939.2 6955.4 7071.4 7104.8 1991.2 2026.8 2040.3 2071.4 2183.3 827.9 847.2 874.8 888.9 889.5 16568.5 16616.1 16980.2 17188.6 17194.4 871.1 884.6 893.1 903.1 906.4 9068.3 9163.6 9275.4 10896.6 11868.5 356360.0 360780.0 362950.0 363109.0 372913.0 72913.0 74065.6 75560.0 76566.0 77642.0 1051.4 1066.3 1096.3 1110.5 1114.5 17114.5 17382.4 17541.2 18040.3 18227.0 38548.8 38729.0 38861.8 39396.2 40274.0 48192.8 49213.8 49439.8 50213.7 50791.0 7991.0 8015.3 8034.0 8037.5 8481.0 11834.7 11924.0 12042.2 12300.3 12596.2 10273.0 10561.3 10663.0 10726.4 10920.1 9301.7 9539.0 9555.3 9658.6 9885.6 10642.4 10780.2 10789.1 10883.2 11094.0 8062.7 8177.9 8189.9 8192.4 8234.4 10062.6 10235.5 10372.7 10403.0 10827.0 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#3] mootools.html Cycles:180 Average:6451.10 Median:3878.22 stddev:4217.14 (108.7%) stddev-sans-first:4210.96 03:02:06 INFO - PID 13187 | Values: 1264.0 1329.2 1330.1 1330.9 1344.7 10129.0 10602.3 10602.8 10610.8 10901.7 9999.0 10147.3 10158.2 10168.4 10195.4 2200.1 2233.2 2243.7 2246.2 2248.7 2161.9 2202.5 2218.4 2221.2 2224.6 1907.1 1943.0 1946.1 1955.1 1956.4 2118.0 2128.7 2132.4 2137.1 2138.5 1893.9 2016.8 2069.8 2131.3 2131.4 10319.8 10408.2 10412.2 10414.5 10415.6 5430.7 5634.9 5636.5 5637.4 5638.1 3190.5 3334.4 3393.9 3397.1 3411.0 1067.7 1090.7 1094.9 1103.9 1110.3 15180.3 15213.5 15337.8 15384.9 15448.5 4551.3 4572.8 4786.7 4802.6 4844.6 11017.5 11021.8 11026.6 11033.8 11053.2 5420.0 5536.8 5539.1 5547.6 5560.3 5098.8 5160.1 5161.2 5176.8 5181.3 3824.9 3848.2 3908.3 3911.3 3963.9 1036.7 1042.5 1059.7 1063.3 1066.2 712.1 742.5 743.8 751.5 759.5 5606.8 5664.7 5708.5 5732.2 5765.3 547.1 575.1 576.1 579.1 822.1 4022.2 4043.5 4076.4 4097.6 4206.7 13672.9 13903.4 14137.6 14147.4 14211.1 13885.2 13920.1 13921.2 13928.2 14011.7 6878.2 7283.2 7289.3 7359.8 7452.6 6291.4 6495.4 6500.3 6540.7 6694.3 12159.5 12350.1 12519.6 12530.9 12713.8 12166.9 12226.3 12536.5 12542.9 12719.9 9632.7 9896.8 9899.0 9946.6 9962.5 9353.8 9663.1 9749.5 9757.2 9816.0 8074.0 8278.7 8287.1 8327.5 8352.9 7821.8 7993.2 8107.4 8238.4 8414.9 7684.2 7730.0 7766.1 7771.5 7777.1 5250.6 5305.4 5345.1 5586.3 5758.5 5591.4 5665.8 5671.6 5731.1 5821.6 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#4] prototype.html Cycles:180 Average:4893.20 Median:5508.39 stddev:1382.86 (25.1%) stddev-sans-first:1344.23 03:02:06 INFO - PID 13187 | Values: 360.1 375.3 380.6 384.2 387.5 5433.5 5615.7 5623.4 5643.3 5651.3 5409.5 5551.2 5553.7 5557.1 5585.3 4393.1 4399.8 4402.6 4405.1 4412.2 4355.0 4375.4 4406.8 4412.5 4420.1 4372.6 4376.5 4380.2 4399.5 4402.6 4322.6 4330.6 4331.6 4331.8 4354.6 3923.1 3977.8 3978.5 4005.4 4015.4 5444.4 5451.8 5471.6 5483.3 5537.6 5211.0 5217.9 5245.6 5248.4 5255.3 5753.2 5867.0 5914.2 5948.5 5958.2 4462.4 4471.7 4484.6 4493.3 4500.7 5969.6 6137.5 6159.1 6169.6 6219.3 4316.1 4323.7 4335.2 4337.1 4338.2 4393.4 4396.4 4397.3 4398.2 4426.9 4960.8 4976.4 4997.8 5146.1 5188.8 5905.9 5909.2 5922.5 5939.8 5942.3 1604.7 1628.2 1633.9 1637.3 1638.3 1153.9 1174.7 1175.3 1181.4 1194.5 5044.7 5062.1 5068.6 5080.1 5088.2 6051.8 6074.1 6075.8 6085.6 6106.6 4844.7 4953.7 4995.4 5000.7 5004.9 3150.8 3178.2 3228.1 3229.5 3238.7 5533.5 5577.5 5596.3 5607.5 5640.5 6141.1 6181.7 6204.1 6207.3 6217.9 5554.9 5606.5 5617.0 5653.0 5653.2 5948.3 6016.1 6042.8 6053.2 6081.5 5718.5 5960.8 5980.1 5999.6 6004.4 5543.9 5575.8 5584.8 5595.2 5598.9 4071.6 4115.6 4117.3 4121.8 4123.2 5887.1 6024.7 6026.9 6095.4 6096.8 5843.2 5872.6 5878.6 5912.6 5920.7 5809.0 5835.0 5862.7 5878.8 5879.6 5719.5 5722.1 5760.7 5770.5 5800.9 5834.8 5846.9 5879.2 5894.3 5896.7 5586.5 5678.0 5679.9 5710.0 5717.7 03:02:06 INFO - PID 13187 | 03:02:06 INFO - PID 13187 | [#5] yui.html Cycles:180 Average:17028.32 Median:3652.06 stddev:22454.49 (614.8%) stddev-sans-first:22483.95 03:02:06 INFO - PID 13187 | Values: 685.4 689.7 697.9 746.5 771.0 11991.3 12496.8 13476.3 14104.9 14127.5 15199.0 15818.4 15842.9 15878.8 15930.2 885.4 903.0 906.8 907.2 907.4 916.4 917.1 917.4 919.1 921.2 967.0 972.0 977.0 978.1 978.7 953.3 960.8 964.0 964.1 965.5 684.9 686.3 689.3 689.6 691.2 14767.4 14907.0 14937.2 14938.5 14945.6 15802.2 15998.5 16230.4 16234.2 16270.5 12719.0 12980.7 13104.4 13251.5 13253.0 2947.1 2947.1 2955.4 2961.6 2970.9 76213.6 76214.2 76256.2 76964.0 77020.6 11120.7 11314.0 11330.3 11372.4 11389.7 17983.0 18156.6 18245.1 18325.7 18652.2 6318.9 6412.0 6413.2 6416.1 6417.1 3023.8 3072.5 3087.6 3088.6 3096.4 3634.7 3669.4 3690.8 3699.9 3739.3 586.3 595.8 735.1 764.5 764.9 585.6 593.2 600.6 602.0 621.2 10068.4 10714.7 10945.8 11182.9 11350.7 562.1 571.6 574.0 581.7 583.2 4812.5 4830.3 4832.8 4890.0 4995.7 83805.6 83992.0 85907.0 86060.6 86601.0 73549.0 74647.6 75002.0 75154.2 76437.6 65103.0 65390.0 65413.7 66065.0 67657.3 9189.4 9852.8 9912.7 9934.3 9951.8 28957.5 29023.4 29123.9 29491.0 30311.8 38012.6 38107.6 38238.4 38960.4 39038.6 12309.0 12318.9 12389.4 12455.8 12464.6 13546.9 13638.7 13697.1 13740.9 13933.6 12695.0 12962.6 13336.0 14190.6 14535.4 13051.9 13585.4 13930.4 14205.5 14239.7 13305.1 13638.5 13971.4 13974.7 14100.9 11076.7 11108.9 11228.6 11394.8 11453.4 12305.9 12736.7 12858.7 12861.9 12875.5 03:02:06 INFO - PID 13187 | -------- Summary: end -------- 03:02:06 INFO - PID 13187 | 03:02:07 INFO - TEST-INFO | 13187: exit 0 03:02:07 INFO - TEST-OK | dromaeo_css | took 1147844ms 03:02:07 INFO - TEST-START | kraken 03:02:07 INFO - operating with platform_type : linux_ 03:02:07 INFO - Initialising browser for kraken test... 03:02:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55482/getInfo.html -profile /tmp/tmp0Jh2Iv/profile 03:02:07 INFO - TEST-INFO | started process 13610 (/builds/slave/test/build/application/firefox/firefox http://localhost:55482/getInfo.html) 03:02:42 INFO - TEST-INFO | 13610: killed by SIGTERM 03:02:42 INFO - Browser initialized. 03:02:42 INFO - Running cycle 1/1 for kraken test... 03:02:42 INFO - TEST-INFO | started process 13832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Jh2Iv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:54 INFO - PID 13832 | RSS: Main: 172281856 03:02:54 INFO - PID 13832 | 03:02:57 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-beat-detection) 03:02:58 INFO - PID 13832 | RSS: Main: 179240960 03:02:58 INFO - PID 13832 | 03:03:01 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-dft) 03:03:01 INFO - PID 13832 | RSS: Main: 177909760 03:03:01 INFO - PID 13832 | 03:03:04 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-fft) 03:03:05 INFO - PID 13832 | RSS: Main: 175878144 03:03:05 INFO - PID 13832 | 03:03:07 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-oscillator) 03:03:07 INFO - PID 13832 | RSS: Main: 176033792 03:03:07 INFO - PID 13832 | 03:03:10 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:03:10 INFO - PID 13832 | RSS: Main: 176406528 03:03:10 INFO - PID 13832 | 03:03:13 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-darkroom) 03:03:14 INFO - PID 13832 | RSS: Main: 177307648 03:03:14 INFO - PID 13832 | 03:03:18 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-desaturate) 03:03:18 INFO - PID 13832 | RSS: Main: 176898048 03:03:18 INFO - PID 13832 | 03:03:21 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55482/tests/kraken/driver.html?testName=json-parse-financial) 03:03:22 INFO - PID 13832 | RSS: Main: 176955392 03:03:22 INFO - PID 13832 | 03:03:23 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:03:24 INFO - PID 13832 | RSS: Main: 177418240 03:03:24 INFO - PID 13832 | 03:03:26 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:03:26 INFO - PID 13832 | RSS: Main: 176652288 03:03:26 INFO - PID 13832 | 03:03:29 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:03:29 INFO - PID 13832 | RSS: Main: 177459200 03:03:29 INFO - PID 13832 | 03:03:32 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:03:33 INFO - PID 13832 | RSS: Main: 176951296 03:03:33 INFO - PID 13832 | 03:03:36 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:03:37 INFO - PID 13832 | RSS: Main: 177016832 03:03:37 INFO - PID 13832 | 03:03:38 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55482/tests/kraken/driver.html?testName=ai-astar) 03:03:39 INFO - PID 13832 | RSS: Main: 178814976 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | __start_tp_report 03:03:39 INFO - PID 13832 | _x_x_mozilla_page_load 03:03:39 INFO - PID 13832 | _x_x_mozilla_page_load_details 03:03:39 INFO - PID 13832 | |i|pagename|runs| 03:03:39 INFO - PID 13832 | |0;ai-astar;104;112;110;110;110;113;112;110;111;111 03:03:39 INFO - PID 13832 | |1;audio-beat-detection;146;126;125;168;130;123;123;125;146;132 03:03:39 INFO - PID 13832 | |2;audio-dft;165;171;163;168;169;168;167;164;163;164 03:03:39 INFO - PID 13832 | |3;audio-fft;75;74;73;108;73;74;74;74;96;77 03:03:39 INFO - PID 13832 | |4;audio-oscillator;83;83;113;83;84;85;96;84;84;115 03:03:39 INFO - PID 13832 | |5;imaging-gaussian-blur;114;115;114;114;114;114;113;114;113;114 03:03:39 INFO - PID 13832 | |6;imaging-darkroom;151;150;150;151;151;152;151;151;151;151 03:03:39 INFO - PID 13832 | |7;imaging-desaturate;94;96;94;95;94;94;94;101;94;94 03:03:39 INFO - PID 13832 | |8;json-parse-financial;55;56;56;55;55;57;56;56;57;55 03:03:39 INFO - PID 13832 | |9;json-stringify-tinderbox;56;57;58;56;56;57;56;56;56;56 03:03:39 INFO - PID 13832 | |10;stanford-crypto-aes;96;89;86;87;88;88;98;89;125;86 03:03:39 INFO - PID 13832 | |11;stanford-crypto-ccm;144;141;135;138;133;132;135;139;135;146 03:03:39 INFO - PID 13832 | |12;stanford-crypto-pbkdf2;191;201;201;193;206;188;199;195;194;183 03:03:39 INFO - PID 13832 | |13;stanford-crypto-sha256-iterative;78;74;74;75;75;74;73;71;72;76 03:03:39 INFO - PID 13832 | __end_tp_report 03:03:39 INFO - PID 13832 | __start_cc_report 03:03:39 INFO - PID 13832 | _x_x_mozilla_cycle_collect,892 03:03:39 INFO - PID 13832 | __end_cc_report 03:03:39 INFO - PID 13832 | __startTimestamp1495793019206__endTimestamp 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | ------- Summary: start ------- 03:03:39 INFO - PID 13832 | Number of tests: 14 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.45 (2.2%) stddev-sans-first:1.12 03:03:39 INFO - PID 13832 | Values: 104.0 112.0 110.0 110.0 110.0 113.0 112.0 110.0 111.0 111.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:131.00 stddev:14.65 (11.2%) stddev-sans-first:14.92 03:03:39 INFO - PID 13832 | Values: 146.0 126.0 125.0 168.0 130.0 123.0 123.0 125.0 146.0 132.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#2] audio-dft Cycles:10 Average:166.20 Median:167.50 stddev:2.78 (1.7%) stddev-sans-first:2.92 03:03:39 INFO - PID 13832 | Values: 165.0 171.0 163.0 168.0 169.0 168.0 167.0 164.0 163.0 164.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:12.09 (16.3%) stddev-sans-first:12.70 03:03:39 INFO - PID 13832 | Values: 75.0 74.0 73.0 108.0 73.0 74.0 74.0 74.0 96.0 77.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.00 stddev:12.74 (15.2%) stddev-sans-first:13.18 03:03:39 INFO - PID 13832 | Values: 83.0 83.0 113.0 83.0 84.0 85.0 96.0 84.0 84.0 115.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:03:39 INFO - PID 13832 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:03:39 INFO - PID 13832 | Values: 151.0 150.0 150.0 151.0 151.0 152.0 151.0 151.0 151.0 151.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.21 (2.4%) stddev-sans-first:2.32 03:03:39 INFO - PID 13832 | Values: 94.0 96.0 94.0 95.0 94.0 94.0 94.0 101.0 94.0 94.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 03:03:39 INFO - PID 13832 | Values: 55.0 56.0 56.0 55.0 55.0 57.0 56.0 56.0 57.0 55.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 03:03:39 INFO - PID 13832 | Values: 56.0 57.0 58.0 56.0 56.0 57.0 56.0 56.0 56.0 56.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.50 stddev:11.90 (13.4%) stddev-sans-first:12.57 03:03:39 INFO - PID 13832 | Values: 96.0 89.0 86.0 87.0 88.0 88.0 98.0 89.0 125.0 86.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:138.50 stddev:4.69 (3.4%) stddev-sans-first:4.40 03:03:39 INFO - PID 13832 | Values: 144.0 141.0 135.0 138.0 133.0 132.0 135.0 139.0 135.0 146.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:197.00 stddev:6.85 (3.5%) stddev-sans-first:7.11 03:03:39 INFO - PID 13832 | Values: 191.0 201.0 201.0 193.0 206.0 188.0 199.0 195.0 194.0 183.0 03:03:39 INFO - PID 13832 | 03:03:39 INFO - PID 13832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.50 stddev:1.99 (2.7%) stddev-sans-first:1.56 03:03:39 INFO - PID 13832 | Values: 78.0 74.0 74.0 75.0 75.0 74.0 73.0 71.0 72.0 76.0 03:03:39 INFO - PID 13832 | -------- Summary: end -------- 03:03:39 INFO - PID 13832 | 03:03:40 INFO - TEST-INFO | 13832: exit 0 03:03:40 INFO - TEST-OK | kraken | took 92940ms 03:03:40 INFO - SUITE-END | took 1240s 03:03:40 INFO - Completed test suite (00:20:40) 03:03:40 INFO - javascript benchmark 03:03:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6819.356384202187, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.82340647858, 2722.1153125234296, 2747.3131717070733, 2777.0835624243996, 2779.277387879151, 5230.372355317368, 5388.137897936331, 5392.4068352481245, 5432.293801805765, 5439.0209762242785, 5273.2617433559335, 5304.734763261831, 5357.812476563321, 5388.191771234317, 5435.619506634537, 4747.881302967437, 4771.117343291502, 4803.639727020462, 4814.205656066745, 4828.97585512072, 4743.217369134089, 4794.616430685537, 4844.0, 4847.587955023827, 4903.2645103234445, 4646.303054541846, 4685.344051832746, 4788.377510923558, 4796.616270698336, 4841.273808928671, 4757.619390448755, 4759.904801903943, 4814.446338671062, 4826.855194344175, 4827.203511420611, 4744.217204161309, 4756.143894099061, 4764.976175119137, 4769.2607645814605, 4811.061842940628, 5147.433782283946, 5309.787608495655, 5331.546818520392, 5335.413104558495, 5356.892862142735, 5688.061469857468, 5711.514521265697, 5722.799702010451, 5801.390853960315, 5830.0380437227805, 5839.678817665027, 5850.3272123705465, 5851.590388672795, 5854.912176317359, 5910.763569457216, 5373.059714550016, 5384.67691938481, 5401.972990135024, 5406.702631355313, 5419.539339156216, 5761.942380576224, 5828.6502809831545, 5838.737256823453, 5935.465808077208, 5960.225170727777, 5600.299962504687, 5660.773569057274, 5679.517241034476, 5693.0, 5710.486056254957, 5600.803971860965, 5696.914546281809, 5712.171735098387, 5718.571107166979, 5728.742206600713, 5581.5813813963305, 5668.206451096849, 5682.318121825325, 5697.4302569742695, 5698.401667824902, 5665.971670141623, 5741.052726300114, 5764.481196692318, 5771.682557459296, 5772.0, 4508.639308855284, 4518.254488009507, 4524.864254072383, 4547.590716835501, 4563.361129441881, 3859.671927886105, 3870.303345397799, 3872.244912242142, 3900.1029763154634, 3915.060385507458, 4750.358701575312, 4808.2547205183255, 4815.2054910940005, 4844.055409195244, 4892.68197567157, 5736.971315143398, 5763.510101641324, 5778.566607504454, 5785.88428231433, 5832.416758324133, 4831.323614693945, 4850.442199147144, 4851.417829860439, 4859.2954021666665, 4894.339264199359, 4930.383702037246, 5011.599072074152, 5061.164907790173, 5074.035933172685, 5079.72061536619, 5277.894442111213, 5321.494458026481, 5337.252784610236, 5363.222332761806, 5375.1131063374105, 5593.664380137205, 5694.4590263924865, 5773.769049237983, 5818.970905145447, 5820.679862607428, 5268.1834315681135, 5303.655262407931, 5305.442928492453, 5352.116900711339, 5409.1345384739825, 5578.944210557843, 5704.885902281848, 5710.914336284876, 5727.599068065362, 5735.197072409783, 5671.262735844314, 5746.9712651436475, 5757.5681823864215, 5796.8550786229, 5836.095405212199, 5548.750306236309, 5581.051221292471, 5582.3859375467855, 5611.102223644198, 5665.348484924287, 5553.750081246273, 5557.277553917965, 5560.138178582326, 5565.332160140809, 5611.130274807411, 5449.2371068049715, 5481.260029895913, 5494.7802087917635, 5499.9175012375645, 5500.092484739973, 5515.420880807457, 5583.508036338322, 5606.579506536945, 5628.043232650377, 5679.659220446786, 5512.118061110203, 5538.501534861882, 5545.057340252086, 5565.554755619622, 5570.2480165177185], "value": 5191.429488575086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.7274581048865, 721.7509959064123, 742.5396254322319, 1035.099463466784, 1059.4437920091946, 33187.50218746721, 34016.65983340166, 34258.8287058565, 34264.82867585665, 34323.82838085809, 35783.821080894624, 35949.0, 36263.0, 36310.09224769382, 36378.09054773632, 6849.1096157499705, 6914.3777060064585, 7015.4036906862975, 7065.717371305142, 7088.149422069333, 6948.617826019567, 7001.789946301619, 7034.613096279702, 7049.788506344792, 7055.223925368231, 7026.208316879214, 7026.332498412668, 7026.683799229021, 7034.472414568902, 7086.0, 7005.754798582051, 7046.7533636323, 7061.788146355618, 7065.682044307992, 7067.505274630778, 6898.241193468714, 6919.827004324882, 6925.065116209297, 6937.861242775116, 6981.685824137926, 33570.32859342799, 33799.324013519836, 34051.82974085138, 34070.65929340725, 34129.14677133067, 3059.1128572713887, 3098.9690103098906, 3103.1001009707156, 3115.143335582733, 3120.0483852425, 25138.371540711447, 25262.873685631454, 25289.0, 25310.746892531206, 25329.366765831, 2945.0, 2950.8524573771224, 2955.733983941434, 2963.5554666799935, 2972.8662210200378, 150580.0, 151122.0, 157077.0, 160620.19689901476, 161253.0, 40812.0, 40824.387634185514, 40989.0, 41019.58980410217, 41109.38335924964, 42147.0, 42258.78870605627, 42268.15463690709, 42284.0, 42375.491186145606, 12801.551945682042, 12819.35903204836, 12950.287734174522, 12977.675558110934, 12978.286194259217, 10420.32267902584, 10527.842082368617, 10537.84193237102, 10544.416617928657, 10578.365298082139, 12860.228386296852, 12925.353732313346, 12977.0, 13021.739565208643, 13054.738905221842, 5179.637425380187, 5341.519263266325, 5403.5136837684795, 5409.134538473825, 5420.403755586883, 826.5412695953803, 896.9416987895765, 904.8778414913902, 906.7959709065408, 912.2519533982204, 20986.969919442152, 21442.678359824615, 21577.24479643205, 21758.129674813146, 21943.341699749035, 983.7983213441228, 989.7327721515151, 1005.7183988483237, 1006.1045669354135, 1006.2918146629693, 11275.097992160607, 11400.94299528497, 11576.76846463066, 11630.6510804676, 11674.124440666985, 178738.0, 180790.09604952155, 180819.0, 181078.0, 181349.0, 41794.49233046027, 41963.37054944178, 42023.0, 42074.0, 42145.78927105345, 1216.2702378572785, 1257.0132446029822, 1259.911806173559, 1263.4270333434931, 1268.9936550317188, 19658.60682786365, 19922.0, 20236.0, 21503.677444838027, 21527.8923605381, 30133.246668833453, 30355.544666830458, 30368.69631303747, 30384.240393990327, 30434.0, 150405.24797375943, 151420.07249093862, 151767.2411637935, 151769.0, 152699.0, 29662.555061673662, 30053.0, 30117.849410753683, 30300.272975432315, 30331.545026825057, 36618.26763464769, 36662.8166859164, 36805.63194368129, 36891.446628301135, 37189.62810371862, 25482.399603371345, 26733.598996014687, 27086.1874143776, 27701.722982769916, 28222.85888570544, 25732.742672573782, 27093.593596096467, 27237.72762272352, 28090.578641320804, 28457.0, 30784.384312314076, 30939.84530077335, 31028.844855775576, 31074.0, 31103.377932440773, 25958.610620840325, 26635.7336426641, 26650.333741656614, 26928.73071269262, 27328.590071149345, 20017.6997345037, 22251.0, 22369.77925996465, 22625.2081177158, 22657.773422265567], "value": 14692.26040368691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.5688740597184, 422.82875435448653, 427.33335995846494, 433.83080598566556, 440.1087797210648, 14144.78782818256, 14589.781153282709, 17130.48608541744, 17914.014729189905, 18043.097845107743, 18842.71735923962, 19000.429987100375, 19187.32844350448, 19327.710084348746, 19401.223951041942, 5435.809746658868, 5443.591730620199, 5454.072807622713, 5607.43925607438, 5623.156526521014, 5425.26758887551, 5561.63849349791, 5568.1091025435935, 5569.777208911639, 5573.442655734435, 4961.826336078238, 5342.839714808562, 5356.651817631841, 5365.7853685852715, 5549.278593782803, 5381.838544843661, 5401.675899446046, 5404.7838086476495, 5412.702301373423, 5414.35027796665, 4880.438749543812, 4940.530649588283, 4946.282788995612, 4955.653104282702, 4980.128477516457, 21742.45643858916, 21885.234016809336, 22006.669899951514, 22080.2271920482, 22106.778932210633, 1608.4450864451862, 1647.7693122962794, 1649.8845080844346, 1660.8256133106092, 1662.742274947385, 13988.090774099652, 14333.283335833166, 14796.18620975846, 14934.402623895032, 14938.477153299691, 2050.5796311756053, 2053.065855035955, 2086.228095604636, 2101.642720737478, 2107.1782005018053, 71038.64480677563, 83869.58065209635, 86572.56713716454, 86599.5670021646, 88367.55816220878, 10841.457927103613, 10916.524225067684, 11110.777934370833, 11121.16591255643, 11383.373914434786, 15807.841921580866, 15883.0, 15919.920400397923, 15991.040537567784, 16017.759733604005, 7468.290512401313, 7502.511332230539, 7683.538987660758, 7716.6527506262355, 7718.498297610638, 6827.283135270725, 6883.586984780929, 7068.787936361918, 7080.858382832314, 7081.539699919489, 6937.653117344214, 6939.167299924042, 6955.443564514827, 7071.36357727807, 7104.786856394317, 1991.2134706791026, 2026.8277196438173, 2040.2960978462406, 2071.440711008019, 2183.3013435700423, 827.9461834980707, 847.220557087481, 874.7638137702785, 888.8711136885245, 889.5063239901788, 16568.502944911674, 16616.086115263533, 16980.150992450574, 17188.570285742706, 17194.398196063077, 871.107115206918, 884.5533005832142, 893.1381217125376, 903.051795614602, 906.4017748286232, 9068.319876009326, 9163.58763855628, 9275.397099188665, 10896.618618348479, 11868.465919033664, 356360.0, 360780.0, 362950.0, 363109.0, 372913.0, 72913.0, 74065.62967185129, 75560.0, 76566.0, 77642.0, 1051.3796859852876, 1066.2673156121302, 1096.3476731344838, 1110.4669758515959, 1114.4594871487323, 17114.48656540306, 17382.391616293367, 17541.21064552073, 18040.2783888643, 18227.0, 38548.80725596354, 38729.0, 38861.8056909725, 39396.2120757589, 40274.0, 48192.759036206, 49213.753931230116, 49439.752801235765, 50213.74893125511, 50791.0, 7991.0, 8015.318697910743, 8034.0, 8037.517748935083, 8480.95759521223, 11834.704132396759, 11924.0, 12042.21725587834, 12300.261984280973, 12596.244225346509, 10273.02406271403, 10561.313514621525, 10663.0, 10726.356418614909, 10920.071793897609, 9301.674441394789, 9539.0, 9555.331126821335, 9658.647789309362, 9885.604575816888, 10642.361458312216, 10780.191485638765, 10789.082927951213, 10883.183761218099, 11094.00153986145, 8062.717804876801, 8177.914631769098, 8189.918100818915, 8192.426530142833, 8234.423590348619, 10062.647807326708, 10235.539400727133, 10372.740681483023, 10403.0, 10827.0], "value": 8772.551781725455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.9936800316, 1329.155985948922, 1330.068951733786, 1330.9201447913126, 1344.6839992601738, 10129.0, 10602.310849794758, 10602.78794424112, 10610.78778424431, 10901.727456813584, 9999.0, 10147.340422872508, 10158.1873450124, 10168.44073575953, 10195.4392508412, 2200.130948275434, 2233.2406981626245, 2243.741969673484, 2246.168917500527, 2248.6627005949076, 2161.9243326483574, 2202.5484775620957, 2218.4010317214343, 2221.178164079293, 2224.5773303072447, 1907.122723547163, 1942.9805701942942, 1946.0561627610598, 1955.1104247567323, 1956.3739603326942, 2118.0, 2128.70198172256, 2132.4349047502346, 2137.1344605434824, 2138.518833262511, 1893.867429279951, 2016.828569571588, 2069.813716765483, 2131.26471367378, 2131.4245153808383, 10319.793604127875, 10408.167346612252, 10412.219083568687, 10414.479276036167, 10415.583376665, 5430.6741595504, 5634.943650563483, 5636.464535869086, 5637.436256374371, 5638.069718496443, 3190.457622204231, 3334.433146365124, 3393.898183054512, 3397.13373089863, 3411.0449074259245, 1067.6583493282153, 1090.6727981605566, 1094.9069329107035, 1103.862017247844, 1110.3337997201695, 15180.316885740169, 15213.543593692208, 15337.77602247679, 15384.923075384551, 15448.459303924308, 4551.3173024046, 4572.8399506017795, 4786.688865223749, 4802.639802014863, 4844.612431005511, 11017.504212310465, 11021.83467247992, 11026.574153686177, 11033.83449248262, 11053.17101217412, 5419.972900135474, 5536.8062117826485, 5539.086050801653, 5547.55619550435, 5560.332760068818, 5098.770555325019, 5160.148575485078, 5161.200013997836, 5176.844694659091, 5181.326427564392, 3824.9426258606145, 3848.191879705237, 3908.257431088084, 3911.2959667259597, 3963.8810835674976, 1036.7149034015706, 1042.5360714482135, 1059.692689120162, 1063.3194755356578, 1066.2376400873413, 712.1454254894147, 742.5396254322354, 743.84007438401, 751.549070557661, 759.4911409355744, 5606.831795046155, 5664.745086471119, 5708.543316534668, 5732.16883551891, 5765.279340082489, 547.0918275662382, 575.1344226938431, 576.1156624581248, 579.0850456279153, 822.1039067416544, 4022.155347377025, 4043.454133691973, 4076.4496792932573, 4097.631213190827, 4206.705530612828, 13672.863271367358, 13903.4438622456, 14137.646558835906, 14147.434102635985, 14211.147331160164, 13885.236312002937, 13920.095193812369, 13921.164730116225, 13928.233947132801, 14011.71976560463, 6878.174619045646, 7283.235260297804, 7289.271072892774, 7359.816004599821, 7452.552846829208, 6291.370862913672, 6495.350464953467, 6500.349965003462, 6540.738370465128, 6694.297098804555, 12159.513619455123, 12350.135490515577, 12519.56181533642, 12530.934870535742, 12713.8092928608, 12166.878331216929, 12226.266424014588, 12536.498540058295, 12542.874571254535, 12719.87280127187, 9632.662856799978, 9896.802063958536, 9898.950505247716, 9946.55240514193, 9962.50187490608, 9353.812923741623, 9663.13031827139, 9749.463779492196, 9757.21942244633, 9815.950920245354, 8073.950386449724, 8278.675411934062, 8287.088420273645, 8327.54198519063, 8352.916470835215, 7821.765347039598, 7993.1607181247455, 8107.351411886917, 8238.423310368216, 8414.873776893473, 7684.231576842271, 7729.961350193213, 7766.106897706836, 7771.494852834548, 7777.144514103557, 5250.579953603627, 5305.363356397257, 5345.091334473072, 5586.329640443173, 5758.481736643722, 5591.384947655836, 5665.801696940587, 5671.574631902541, 5731.054376027909, 5821.621594596338], "value": 4774.1082496184545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.11950780342056, 375.3131768862981, 380.6060727147403, 384.22578504313793, 387.5330227076373, 5433.4566543345645, 5615.66306021639, 5623.381428042912, 5643.3036361183495, 5651.3218413790355, 5409.540189083933, 5551.1673249012665, 5553.694546799924, 5557.110862262039, 5585.301837270341, 4393.05549306899, 4399.824007039714, 4402.635183093252, 4405.096955124208, 4412.205802955466, 4354.956450435503, 4375.387445757597, 4406.823727050914, 4412.492563355223, 4420.07178492517, 4372.6283265922275, 4376.474823021242, 4380.167768124046, 4399.472063352387, 4402.625776808975, 4322.6325762309925, 4330.631896288819, 4331.581786577704, 4331.826726930919, 4354.629856462205, 3923.097687531884, 3977.840886364571, 3978.5225772907147, 4005.419214213952, 4015.3976903464422, 5444.428335024805, 5451.792024230153, 5471.616986810925, 5483.259759932438, 5537.58468114893, 5211.0, 5217.895642087137, 5245.606579506552, 5248.396434410053, 5255.316808814868, 5753.194552762617, 5867.002609556343, 5914.2015827863115, 5948.464638182541, 5958.165856780054, 4462.419885414908, 4471.690948697973, 4484.596386325246, 4493.348464472666, 4500.662450316239, 5969.611975221596, 6137.508999280091, 6159.137720719103, 6169.629822210637, 6219.253689557237, 4316.136772645484, 4323.718958267703, 4335.154644844225, 4337.110892267077, 4338.197433474817, 4393.362962370502, 4396.428464299621, 4397.274449715761, 4398.208322501916, 4426.911461770746, 4960.751962401865, 4976.377952755905, 4997.750112494361, 5146.099432599281, 5188.818391356284, 5905.940940590625, 5909.172715819789, 5922.49658779, 5939.792107276311, 5942.286925568959, 1604.6549991751829, 1628.202180931335, 1633.901965882051, 1637.3368785641835, 1638.3119089982235, 1153.9307641541366, 1174.6652204121956, 1175.2713317743055, 1181.4033912874115, 1194.5102507971865, 5044.672096313728, 5062.114130027304, 5068.594512438996, 5080.13637681595, 5088.211327244283, 6051.789642071603, 6074.149619053336, 6075.817725468243, 6085.57400981927, 6106.603070800384, 4844.709317440965, 4953.67801092935, 4995.400551933792, 5000.74996250186, 5004.874878128003, 3150.826704531227, 3178.1714274295896, 3228.1122691260093, 3229.531717900891, 3238.6923242291946, 5533.529649979716, 5577.498025177753, 5596.3284405870745, 5607.467290607386, 5640.520555752807, 6141.140240366352, 6181.721822517908, 6204.069389591597, 6207.255129384413, 6217.906731399033, 5554.895790036266, 5606.467385598362, 5616.97191514048, 5652.97173514138, 5653.208550802891, 5948.345681974893, 6016.127661488972, 6042.788502402394, 6053.243344581927, 6081.483073938764, 5718.51392631631, 5960.761569537343, 5980.102984552352, 5999.5500337473995, 6004.42957918997, 5543.861403464784, 5575.832725018256, 5584.832455026356, 5595.216669666169, 5598.916016259678, 4071.592840715905, 4115.629593336614, 4117.279476091732, 4121.752694838319, 4123.237201117803, 5887.087501437284, 6024.698765061817, 6026.909596356146, 6095.3904609538695, 6096.75612975476, 5843.211166492469, 5872.588918775645, 5878.617889837147, 5912.586118971631, 5920.733566989582, 5809.0, 5835.0, 5862.739511005155, 5878.823635290948, 5879.617824841372, 5719.5138413235345, 5722.113072473773, 5760.654360738369, 5770.538356931352, 5800.854978625568, 5834.795782147605, 5846.883062338644, 5879.176915231957, 5894.2926848778425, 5896.705164741831, 5586.497215250647, 5677.984315567914, 5679.8864022720145, 5710.0, 5717.685527296038], "value": 4475.908225397312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.417395214068, 689.6930865764733, 697.884848999915, 746.4811955690797, 770.9999999999997, 11991.340476273801, 12496.812547811767, 13476.25880576568, 14104.858951410495, 14127.505537306197, 15199.0, 15818.367265309374, 15842.920785396085, 15878.761818572702, 15930.203489825491, 885.4023534114463, 903.0157128729684, 906.7642412972641, 907.2061945797427, 907.4101833808012, 916.3997581584073, 917.1149840404008, 917.3899356927635, 919.103873723118, 921.1801496667971, 967.0377973915963, 971.9951400242988, 976.9902300977005, 978.149010360987, 978.6721448314823, 953.3469573342248, 960.7886265021684, 964.045594861086, 964.1130160252584, 965.5413678502655, 684.8732984397902, 686.3376841348123, 689.2556039477353, 689.6310473896441, 691.239636399961, 14767.409303627843, 14907.0, 14937.17845518496, 14938.477153299582, 14945.551633451014, 15802.209889505479, 15998.52004439857, 16230.350785968547, 16234.188290585542, 16270.511884643362, 12719.0, 12980.740385192337, 13104.410301536454, 13251.536196233183, 13253.0, 2947.101134154082, 2947.1453278549193, 2955.3793703322326, 2961.570572267031, 2970.866311015988, 76213.61893190499, 76214.23785762126, 76256.23743762547, 76964.0, 77020.61489692572, 11120.721981950515, 11314.0, 11330.263532870336, 11372.374519401346, 11389.715257118638, 17983.0, 18156.63686726258, 18245.08774561293, 18325.7251141233, 18652.160652770657, 6318.936810631927, 6412.038194270804, 6413.166288382574, 6416.133821934072, 6417.069524918954, 3023.7580993520905, 3072.4776787946103, 3087.598612180402, 3088.5521599367967, 3096.442640324718, 3634.6910512606723, 3669.43123815809, 3690.7785532868115, 3699.8520059197867, 3739.2521495700967, 586.2905883880467, 595.7616953218748, 735.1362149474346, 764.5221736414741, 764.9426293028046, 585.5520526797004, 593.2199158107076, 600.5885968111858, 601.9668918209453, 621.1707370660129, 10068.39589624625, 10714.73213169677, 10945.781084378426, 11182.888171118348, 11350.659480215607, 562.1118632560544, 571.5656101362994, 574.0, 581.6975172910063, 583.2359608912338, 4812.51874812516, 4830.275458681226, 4832.782524786393, 4890.0, 4995.725235112031, 83805.58097209597, 83992.0, 85907.0, 86060.56969715112, 86601.0, 73549.0, 74647.62676186585, 75002.0, 75154.24845751582, 76437.61781191059, 65103.0, 65390.0, 65413.67293163504, 66065.0, 67657.32342676609, 9189.402688825205, 9852.802943940938, 9912.702618921443, 9934.254930880068, 9951.800963980535, 28957.525096988495, 29023.41953160967, 29123.85438072796, 29491.0, 30311.848440757654, 38012.61987380202, 38107.618923810405, 38238.42642360311, 38960.41559376555, 39038.6096139035, 12309.0, 12318.876811231772, 12389.380530973596, 12455.813162802746, 12464.626061218178, 13546.86453135456, 13638.727225455237, 13697.109687870257, 13740.862591374358, 13933.58199254024, 12695.0, 12962.611121666365, 13336.0, 14190.57428277112, 14535.418583256975, 13051.934740326238, 13585.388657510239, 13930.373133209232, 14205.502807401692, 14239.715205696035, 13305.135166214164, 13638.522651707142, 13971.441142354191, 13974.650633734238, 14100.929495352457, 11076.723081923017, 11108.944455277671, 11228.606998755004, 11394.772104557696, 11453.427328633701, 12305.876941230474, 12736.6815829605, 12858.742825143632, 12861.935690321863, 12875.549355772502], "value": 7033.233344017954, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 110.0, 110.0, 113.0, 112.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 126.0, 125.0, 168.0, 130.0, 123.0, 123.0, 125.0, 146.0, 132.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 163.0, 168.0, 169.0, 168.0, 167.0, 164.0, 163.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 108.0, 73.0, 74.0, 74.0, 74.0, 96.0, 77.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 83.0, 84.0, 85.0, 96.0, 84.0, 84.0, 115.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 101.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 57.0, 56.0, 56.0, 57.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 89.0, 86.0, 87.0, 88.0, 88.0, 98.0, 89.0, 125.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 135.0, 138.0, 133.0, 132.0, 135.0, 139.0, 135.0, 146.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 201.0, 201.0, 193.0, 206.0, 188.0, 199.0, 195.0, 194.0, 183.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 75.0, 75.0, 74.0, 73.0, 71.0, 72.0, 76.0], "value": 74.2, "unit": "score"}]}]} 03:03:40 INFO - Return code: 0 03:03:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:03:40 INFO - # TBPL SUCCESS # 03:03:40 INFO - Running post-action listener: _resource_record_post_action 03:03:40 INFO - [mozharness: 2017-05-26 10:03:40.515484Z] Finished run-tests step (success) 03:03:40 INFO - Running post-run listener: _resource_record_post_run 03:03:40 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406605824; Read time: 124; Write time: 354492 03:03:40 INFO - TinderboxPrint: CPU usage
12.7% 03:03:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 124 03:03:40 INFO - TinderboxPrint: I/O write bytes / time
406,605,824 / 354,492 03:03:40 INFO - TinderboxPrint: CPU idle
8,759.1 (87.3%) 03:03:40 INFO - TinderboxPrint: CPU user
1,219.1 (12.1%) 03:03:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:03:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95408128; Read time: 0; Write time: 113716 03:03:40 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311197696; Read time: 108; Write time: 240776 03:03:41 INFO - Running post-run listener: _upload_blobber_files 03:03:41 INFO - Blob upload gear active. 03:03:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:03:41 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 03:03:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:03:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:03:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:42 INFO - (blobuploader) - INFO - Done attempting. 03:03:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:03:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:03:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:43 INFO - (blobuploader) - INFO - Done attempting. 03:03:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:03:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:03:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:44 INFO - (blobuploader) - INFO - Done attempting. 03:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:47 INFO - (blobuploader) - INFO - Done attempting. 03:03:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:03:47 INFO - Return code: 0 03:03:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:03:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:03:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c83b4c21e25b5d36e031f04482ba693ae7f0778eff8a87e1d3b39de5af0e06adfaa9c9c6ecb1464eec65152d2afe7cc9a2cad9724686a4f13208cb984b7263", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f57244d66223432c372ff5eabae7e485a96e522ace5493b4dc0e370f7b29881bd246b8e4440c1d5f78c6514e353d7f2729f1c2913104f466f935239f5bb5c2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd69414d9fe90079eb12ed85f3dee92487085cea06e35452680e3510a2ece2293bc32862be31fc1c412cdcaccb623be936069b111a703ee89058cc3fcf791c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd11122ba05f97d0545f3863409d9f2c9c4235b95834e371a05fa054faf156dcb0ae3be4f8aa21e6ff359ea209020d3fd800916ff784659b7db39a06133a03c"} 03:03:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:03:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:03:47 INFO - Contents: 03:03:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c83b4c21e25b5d36e031f04482ba693ae7f0778eff8a87e1d3b39de5af0e06adfaa9c9c6ecb1464eec65152d2afe7cc9a2cad9724686a4f13208cb984b7263", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f57244d66223432c372ff5eabae7e485a96e522ace5493b4dc0e370f7b29881bd246b8e4440c1d5f78c6514e353d7f2729f1c2913104f466f935239f5bb5c2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd69414d9fe90079eb12ed85f3dee92487085cea06e35452680e3510a2ece2293bc32862be31fc1c412cdcaccb623be936069b111a703ee89058cc3fcf791c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd11122ba05f97d0545f3863409d9f2c9c4235b95834e371a05fa054faf156dcb0ae3be4f8aa21e6ff359ea209020d3fd800916ff784659b7db39a06133a03c"} 03:03:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:03:47 INFO - Copying logs to upload dir... 03:03:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:03:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.296476 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-26 03:03:47.467128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 03:03:47.474406) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c83b4c21e25b5d36e031f04482ba693ae7f0778eff8a87e1d3b39de5af0e06adfaa9c9c6ecb1464eec65152d2afe7cc9a2cad9724686a4f13208cb984b7263", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f57244d66223432c372ff5eabae7e485a96e522ace5493b4dc0e370f7b29881bd246b8e4440c1d5f78c6514e353d7f2729f1c2913104f466f935239f5bb5c2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd69414d9fe90079eb12ed85f3dee92487085cea06e35452680e3510a2ece2293bc32862be31fc1c412cdcaccb623be936069b111a703ee89058cc3fcf791c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd11122ba05f97d0545f3863409d9f2c9c4235b95834e371a05fa054faf156dcb0ae3be4f8aa21e6ff359ea209020d3fd800916ff784659b7db39a06133a03c"} build_url:https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/J_CEey7SRvWRCPi0ZJeLZA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c83b4c21e25b5d36e031f04482ba693ae7f0778eff8a87e1d3b39de5af0e06adfaa9c9c6ecb1464eec65152d2afe7cc9a2cad9724686a4f13208cb984b7263", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f57244d66223432c372ff5eabae7e485a96e522ace5493b4dc0e370f7b29881bd246b8e4440c1d5f78c6514e353d7f2729f1c2913104f466f935239f5bb5c2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd69414d9fe90079eb12ed85f3dee92487085cea06e35452680e3510a2ece2293bc32862be31fc1c412cdcaccb623be936069b111a703ee89058cc3fcf791c2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd11122ba05f97d0545f3863409d9f2c9c4235b95834e371a05fa054faf156dcb0ae3be4f8aa21e6ff359ea209020d3fd800916ff784659b7db39a06133a03c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 03:03:47.504314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 03:03:47.504682) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495786617.586259-1005602786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 03:03:47.584804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 03:03:47.588160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 03:03:47.588508) ========= ========= Total master_lag: 0.55 =========